builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0109 starttime: 1475615016.07 results: success (0) buildid: 20161004115303 builduid: 33e88bd7e82a4a0c980d1daab4e5aad5 revision: 2e84262d3d0d8eb3a3f415387b3bd562c2831184 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.074237) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.074670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.074960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.099098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.099412) ========= 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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-10-04 14:03:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-10-04 14:03:36 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168977 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.295046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.295359) ========= 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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.030669 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:36.347419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 14:03:36.347830) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e84262d3d0d8eb3a3f415387b3bd562c2831184 --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 2e84262d3d0d8eb3a3f415387b3bd562c2831184 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-10-04 14:03:36,416 truncating revision to first 12 chars 2016-10-04 14:03:36,417 Setting DEBUG logging. 2016-10-04 14:03:36,417 attempt 1/10 2016-10-04 14:03:36,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2e84262d3d0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 14:03:38,012 unpacking tar archive at: mozilla-aurora-2e84262d3d0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.873207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 14:03:38.242668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:38.242999) ========= script_repo_revision: 2e84262d3d0d8eb3a3f415387b3bd562c2831184 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:38.243379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:38.243703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:03:38.266658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-04 14:03:38.267032) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:03:38 INFO - MultiFileLogger online at 20161004 14:03:38 in /builds/slave/test 14:03:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:03:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:03:38 INFO - {'append_to_log': False, 14:03:38 INFO - 'base_work_dir': '/builds/slave/test', 14:03:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:03:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:03:38 INFO - 'branch': 'Mozilla-Aurora', 14:03:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:38 INFO - 'config_files': ('talos/mac_config.py',), 14:03:38 INFO - 'default_actions': ('clobber', 14:03:38 INFO - 'read-buildbot-config', 14:03:38 INFO - 'download-and-extract', 14:03:38 INFO - 'populate-webroot', 14:03:38 INFO - 'create-virtualenv', 14:03:38 INFO - 'install', 14:03:38 INFO - 'run-tests'), 14:03:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:38 INFO - 'download_minidump_stackwalk': True, 14:03:38 INFO - 'download_symbols': 'ondemand', 14:03:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:38 INFO - 'installer_path': 'installer.exe', 14:03:38 INFO - 'log_level': 'info', 14:03:38 INFO - 'log_name': 'talos', 14:03:38 INFO - 'log_to_console': True, 14:03:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:03:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:03:38 INFO - 'opt_config_files': (), 14:03:38 INFO - 'pip_index': False, 14:03:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:38 INFO - 'cmd': ('bash', 14:03:38 INFO - '-c', 14:03:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:38 INFO - 'enabled': True, 14:03:38 INFO - 'halt_on_failure': False, 14:03:38 INFO - 'name': 'check_screen_resolution'},), 14:03:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:38 INFO - 'cmd': ('bash', 14:03:38 INFO - '-c', 14:03:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:38 INFO - 'enabled': True, 14:03:38 INFO - 'halt_on_failure': False, 14:03:38 INFO - 'name': 'check_screen_resolution'},), 14:03:38 INFO - 'run_cmd_checks_enabled': True, 14:03:38 INFO - 'sps_profile': False, 14:03:38 INFO - 'sps_profile_interval': 0, 14:03:38 INFO - 'suite': 'dromaeojs', 14:03:38 INFO - 'system_bits': '32', 14:03:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:38 INFO - 'title': 't-yosemite-r7-0109', 14:03:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:38 INFO - 'use_talos_json': True, 14:03:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:03:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:38 INFO - 'work_dir': 'build'} 14:03:38 INFO - [mozharness: 2016-10-04 21:03:38.457681Z] Running clobber step. 14:03:38 INFO - Running pre-action listener: _resource_record_pre_action 14:03:38 INFO - Running main action method: clobber 14:03:38 INFO - rmtree: /builds/slave/test/build 14:03:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:03:40 INFO - Running post-action listener: _resource_record_post_action 14:03:40 INFO - [mozharness: 2016-10-04 21:03:40.575027Z] Finished clobber step (success) 14:03:40 INFO - [mozharness: 2016-10-04 21:03:40.575154Z] Running read-buildbot-config step. 14:03:40 INFO - Running pre-action listener: _resource_record_pre_action 14:03:40 INFO - Running main action method: read_buildbot_config 14:03:40 INFO - Using buildbot properties: 14:03:40 INFO - { 14:03:40 INFO - "project": "", 14:03:40 INFO - "product": "firefox", 14:03:40 INFO - "script_repo_revision": "production", 14:03:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:03:40 INFO - "repository": "", 14:03:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:03:40 INFO - "buildid": "20161004115303", 14:03:40 INFO - "pgo_build": "False", 14:03:40 INFO - "basedir": "/builds/slave/test", 14:03:40 INFO - "buildnumber": 31, 14:03:40 INFO - "slavename": "t-yosemite-r7-0109", 14:03:40 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:03:40 INFO - "platform": "yosemite_r7", 14:03:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:03:40 INFO - "branch": "mozilla-aurora", 14:03:40 INFO - "repo_path": "releases/mozilla-aurora", 14:03:40 INFO - "revision": "2e84262d3d0d8eb3a3f415387b3bd562c2831184", 14:03:40 INFO - "stage_platform": "macosx64", 14:03:40 INFO - "builduid": "33e88bd7e82a4a0c980d1daab4e5aad5", 14:03:40 INFO - "slavebuilddir": "test" 14:03:40 INFO - } 14:03:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:03:40 INFO - Running post-action listener: _resource_record_post_action 14:03:40 INFO - [mozharness: 2016-10-04 21:03:40.578376Z] Finished read-buildbot-config step (success) 14:03:40 INFO - [mozharness: 2016-10-04 21:03:40.578517Z] Running download-and-extract step. 14:03:40 INFO - Running pre-action listener: _resource_record_pre_action 14:03:40 INFO - Running main action method: download_and_extract 14:03:40 INFO - mkdir: /builds/slave/test/build/tests 14:03:40 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')]} 14:03:40 INFO - trying https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:03:40 INFO - Downloading https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/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 14:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/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 14:03:41 INFO - Downloaded 1199 bytes. 14:03:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:03:41 INFO - Using the following test package requirements: 14:03:41 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:03:41 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:03:41 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:03:41 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'jsshell-mac.zip'], 14:03:41 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:03:41 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:03:41 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:03:41 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:03:41 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:03:41 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:41 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:03:41 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:03:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:03:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:03:41 INFO - Fetch https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:03:42 INFO - Expected file size: 16434082 14:03:49 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 14:03:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:03:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:03:49 INFO - Fetch https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:03:50 INFO - Expected file size: 16434082 14:03:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:03:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:03:56 INFO - Fetch https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:03:57 INFO - Expected file size: 14414059 14:03:58 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')]} 14:03:58 INFO - trying https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:03:58 INFO - Downloading https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/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 14:04:00 INFO - Downloaded 115273099 bytes. 14:04:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:00 INFO - mkdir: /builds/slave/test/properties 14:04:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:00 INFO - Contents: 14:04:00 INFO - build_url:https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:01 INFO - Running post-action listener: _resource_record_post_action 14:04:01 INFO - Running post-action listener: set_extra_try_arguments 14:04:01 INFO - [mozharness: 2016-10-04 21:04:01.734397Z] Finished download-and-extract step (success) 14:04:01 INFO - [mozharness: 2016-10-04 21:04:01.734509Z] Running populate-webroot step. 14:04:01 INFO - Running pre-action listener: _resource_record_pre_action 14:04:01 INFO - Running main action method: populate_webroot 14:04:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:01 INFO - '--tppagecycles', 14:04:01 INFO - '7'], 14:04:01 INFO - 'tests': ['tsvgm']}}, 14:04:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:04:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:04:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:04:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['damp', 'tps']}, 14:04:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'tests': ['damp', 'tps']}, 14:04:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['dromaeo_dom']}, 14:04:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['basic_compositor_video']}, 14:04:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:04:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['a11yr', 14:04:01 INFO - 'ts_paint', 14:04:01 INFO - 'tpaint', 14:04:01 INFO - 'sessionrestore', 14:04:01 INFO - 'sessionrestore_no_auto_restore', 14:04:01 INFO - 'tabpaint']}, 14:04:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['tsvgx', 14:04:01 INFO - 'tsvgr_opacity', 14:04:01 INFO - 'tart', 14:04:01 INFO - 'tscrollx', 14:04:01 INFO - 'cart']}, 14:04:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:04:01 INFO - 'tsvgr_opacity', 14:04:01 INFO - 'tart', 14:04:01 INFO - 'tscrollx', 14:04:01 INFO - 'cart']}, 14:04:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'talos_options': ['--disable-e10s'], 14:04:01 INFO - 'tests': ['tp5o']}, 14:04:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'tests': ['tp5o']}, 14:04:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'talos_options': ['--disable-e10s', 14:04:01 INFO - '--xperf_path', 14:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:01 INFO - 'tests': ['tp5n']}, 14:04:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:01 INFO - 'talos_options': ['--xperf_path', 14:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:01 INFO - 'tests': ['tp5n']}}, 14:04:01 INFO - 'talos.zip': {'path': '', 14:04:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:01 INFO - Running post-action listener: _resource_record_post_action 14:04:01 INFO - [mozharness: 2016-10-04 21:04:01.753425Z] Finished populate-webroot step (success) 14:04:01 INFO - [mozharness: 2016-10-04 21:04:01.753504Z] Running create-virtualenv step. 14:04:01 INFO - Running pre-action listener: _resource_record_pre_action 14:04:01 INFO - Running main action method: create_virtualenv 14:04:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04:01 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 14:04:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:01 INFO - Using real prefix '/tools/python27' 14:04:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:05 INFO - Installing pip.................done. 14:04:05 INFO - Return code: 0 14:04:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04:05 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')]} 14:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:05 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')]} 14:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:05 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:05 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 14:04:05 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 14:04:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:05 INFO - 'HOME': '/Users/cltbld', 14:04:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:05 INFO - 'LOGNAME': 'cltbld', 14:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:05 INFO - 'MOZ_NO_REMOTE': '1', 14:04:05 INFO - 'NO_EM_RESTART': '1', 14:04:05 INFO - 'PAGER': '/bin/cat', 14:04:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:05 INFO - 'PWD': '/builds/slave/test', 14:04:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:05 INFO - 'SHELL': '/bin/bash', 14:04:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:05 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:05 INFO - 'USER': 'cltbld', 14:04:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:05 INFO - 'XPC_FLAGS': '0x0', 14:04:05 INFO - 'XPC_SERVICE_NAME': '0', 14:04:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:05 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 14:04:05 INFO - Cleaning up... 14:04:05 INFO - Return code: 0 14:04:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:04:05 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')]} 14:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:05 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')]} 14:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:05 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:05 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 14:04:05 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 14:04:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:05 INFO - 'HOME': '/Users/cltbld', 14:04:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:05 INFO - 'LOGNAME': 'cltbld', 14:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:05 INFO - 'MOZ_NO_REMOTE': '1', 14:04:05 INFO - 'NO_EM_RESTART': '1', 14:04:05 INFO - 'PAGER': '/bin/cat', 14:04:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:05 INFO - 'PWD': '/builds/slave/test', 14:04:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:05 INFO - 'SHELL': '/bin/bash', 14:04:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:05 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:05 INFO - 'USER': 'cltbld', 14:04:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:05 INFO - 'XPC_FLAGS': '0x0', 14:04:05 INFO - 'XPC_SERVICE_NAME': '0', 14:04:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:06 INFO - Downloading/unpacking psutil>=3.1.1 14:04:06 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 14:04:06 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 14:04:06 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 14:04:06 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 14:04:06 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 14:04:06 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 14:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:08 INFO - Installing collected packages: psutil 14:04:08 INFO - Running setup.py install for psutil 14:04:08 INFO - building 'psutil._psutil_osx' extension 14:04:08 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 14:04:09 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 14:04:09 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 14:04:09 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 14:04:09 INFO - building 'psutil._psutil_posix' extension 14:04:09 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 14:04:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:04:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:04:09 INFO - ^ 14:04:09 INFO - 1 warning generated. 14:04:09 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 14:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:09 INFO - Successfully installed psutil 14:04:09 INFO - Cleaning up... 14:04:09 INFO - Return code: 0 14:04:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:04:09 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')]} 14:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:09 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')]} 14:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:09 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:09 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 14:04:09 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 14:04:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:09 INFO - 'HOME': '/Users/cltbld', 14:04:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:09 INFO - 'LOGNAME': 'cltbld', 14:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:09 INFO - 'MOZ_NO_REMOTE': '1', 14:04:09 INFO - 'NO_EM_RESTART': '1', 14:04:09 INFO - 'PAGER': '/bin/cat', 14:04:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:09 INFO - 'PWD': '/builds/slave/test', 14:04:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:09 INFO - 'SHELL': '/bin/bash', 14:04:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:09 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:09 INFO - 'USER': 'cltbld', 14:04:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:09 INFO - 'XPC_FLAGS': '0x0', 14:04:09 INFO - 'XPC_SERVICE_NAME': '0', 14:04:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:04:10 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 14:04:10 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 14:04:10 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 14:04:10 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 14:04:10 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 14:04:10 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 14:04:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:04:12 INFO - Installing collected packages: mozsystemmonitor 14:04:12 INFO - Running setup.py install for mozsystemmonitor 14:04:12 INFO - Successfully installed mozsystemmonitor 14:04:12 INFO - Cleaning up... 14:04:12 INFO - Return code: 0 14:04:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:04:12 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')]} 14:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:12 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')]} 14:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:12 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:12 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 14:04:12 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 14:04:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:12 INFO - 'HOME': '/Users/cltbld', 14:04:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:12 INFO - 'LOGNAME': 'cltbld', 14:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:12 INFO - 'MOZ_NO_REMOTE': '1', 14:04:12 INFO - 'NO_EM_RESTART': '1', 14:04:12 INFO - 'PAGER': '/bin/cat', 14:04:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:12 INFO - 'PWD': '/builds/slave/test', 14:04:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:12 INFO - 'SHELL': '/bin/bash', 14:04:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:12 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:12 INFO - 'USER': 'cltbld', 14:04:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:12 INFO - 'XPC_FLAGS': '0x0', 14:04:12 INFO - 'XPC_SERVICE_NAME': '0', 14:04:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:13 INFO - Downloading/unpacking jsonschema==2.5.1 14:04:13 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 14:04:13 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 14:04:13 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 14:04:13 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 14:04:13 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 14:04:13 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 14:04:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:04:15 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 14:04:15 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 14:04:15 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 14:04:15 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 14:04:15 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 14:04:15 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 14:04:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:16 INFO - warning: no files found matching '*.txt' 14:04:16 INFO - no previously-included directories found matching 'build' 14:04:16 INFO - no previously-included directories found matching 'dist' 14:04:16 INFO - no previously-included directories found matching '.git*' 14:04:16 INFO - Installing collected packages: jsonschema, functools32 14:04:16 INFO - Running setup.py install for functools32 14:04:16 INFO - warning: no files found matching '*.txt' 14:04:16 INFO - no previously-included directories found matching 'build' 14:04:16 INFO - no previously-included directories found matching 'dist' 14:04:16 INFO - no previously-included directories found matching '.git*' 14:04:16 INFO - Successfully installed jsonschema functools32 14:04:16 INFO - Cleaning up... 14:04:16 INFO - Return code: 0 14:04:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:04:16 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')]} 14:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:16 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')]} 14:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:16 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:16 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 14:04:16 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 14:04:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:16 INFO - 'HOME': '/Users/cltbld', 14:04:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:16 INFO - 'LOGNAME': 'cltbld', 14:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:16 INFO - 'MOZ_NO_REMOTE': '1', 14:04:16 INFO - 'NO_EM_RESTART': '1', 14:04:16 INFO - 'PAGER': '/bin/cat', 14:04:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:16 INFO - 'PWD': '/builds/slave/test', 14:04:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:16 INFO - 'SHELL': '/bin/bash', 14:04:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:16 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:16 INFO - 'USER': 'cltbld', 14:04:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:16 INFO - 'XPC_FLAGS': '0x0', 14:04:16 INFO - 'XPC_SERVICE_NAME': '0', 14:04:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:04:16 INFO - Cleaning up... 14:04:16 INFO - Return code: 0 14:04:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04:16 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')]} 14:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:16 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')]} 14:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:16 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:16 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 14:04:16 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 14:04:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:16 INFO - 'HOME': '/Users/cltbld', 14:04:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:16 INFO - 'LOGNAME': 'cltbld', 14:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:16 INFO - 'MOZ_NO_REMOTE': '1', 14:04:16 INFO - 'NO_EM_RESTART': '1', 14:04:16 INFO - 'PAGER': '/bin/cat', 14:04:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:16 INFO - 'PWD': '/builds/slave/test', 14:04:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:16 INFO - 'SHELL': '/bin/bash', 14:04:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:16 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:16 INFO - 'USER': 'cltbld', 14:04:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:16 INFO - 'XPC_FLAGS': '0x0', 14:04:16 INFO - 'XPC_SERVICE_NAME': '0', 14:04:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:04:16 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 14:04:16 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 14:04:16 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 14:04:16 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 14:04:16 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 14:04:16 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 14:04:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:19 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 14:04:19 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 14:04:19 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 14:04:19 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 14:04:19 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 14:04:19 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 14:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:20 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 14:04:20 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 14:04:20 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 14:04:20 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 14:04:20 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 14:04:20 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 14:04:20 INFO - Downloading docopt-0.6.1.tar.gz 14:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:20 INFO - Running setup.py install for blobuploader 14:04:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:20 INFO - Running setup.py install for requests 14:04:21 INFO - Running setup.py install for docopt 14:04:21 INFO - Successfully installed blobuploader requests docopt 14:04:21 INFO - Cleaning up... 14:04:21 INFO - Return code: 0 14:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:21 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')]} 14:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:21 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')]} 14:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:21 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:21 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 14:04:21 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 14:04:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:21 INFO - 'HOME': '/Users/cltbld', 14:04:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:21 INFO - 'LOGNAME': 'cltbld', 14:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:21 INFO - 'MOZ_NO_REMOTE': '1', 14:04:21 INFO - 'NO_EM_RESTART': '1', 14:04:21 INFO - 'PAGER': '/bin/cat', 14:04:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:21 INFO - 'PWD': '/builds/slave/test', 14:04:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:21 INFO - 'SHELL': '/bin/bash', 14:04:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:21 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:21 INFO - 'USER': 'cltbld', 14:04:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:21 INFO - 'XPC_FLAGS': '0x0', 14:04:21 INFO - 'XPC_SERVICE_NAME': '0', 14:04:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:21 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-C8EKFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:21 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-hfr5kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-EVBter-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-WBfwb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-DzWofK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-coCMHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-BjgCRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-n2f0Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-G72fNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Ajebut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-YwNZ0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:22 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-LjUaJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:23 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ORZPnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:23 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Fu56Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:23 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-F664dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:23 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-aG1ZzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:23 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ZnCoa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:23 INFO - Running setup.py install for manifestparser 14:04:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:23 INFO - Running setup.py install for mozcrash 14:04:23 INFO - Running setup.py install for mozdebug 14:04:24 INFO - Running setup.py install for mozdevice 14:04:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Running setup.py install for mozfile 14:04:24 INFO - Running setup.py install for mozhttpd 14:04:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Running setup.py install for mozinfo 14:04:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Running setup.py install for mozInstall 14:04:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:24 INFO - Running setup.py install for mozleak 14:04:24 INFO - Running setup.py install for mozlog 14:04:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Running setup.py install for moznetwork 14:04:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Running setup.py install for mozprocess 14:04:25 INFO - Running setup.py install for mozprofile 14:04:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Running setup.py install for mozrunner 14:04:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:25 INFO - Running setup.py install for mozscreenshot 14:04:25 INFO - Running setup.py install for moztest 14:04:26 INFO - Running setup.py install for mozversion 14:04:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:04:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:26 INFO - Cleaning up... 14:04:26 INFO - Return code: 0 14:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04: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')]} 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:26 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:26 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 14:04:26 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 14:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:26 INFO - 'HOME': '/Users/cltbld', 14:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:26 INFO - 'LOGNAME': 'cltbld', 14:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:26 INFO - 'MOZ_NO_REMOTE': '1', 14:04:26 INFO - 'NO_EM_RESTART': '1', 14:04:26 INFO - 'PAGER': '/bin/cat', 14:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:26 INFO - 'PWD': '/builds/slave/test', 14:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:26 INFO - 'SHELL': '/bin/bash', 14:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:26 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:26 INFO - 'USER': 'cltbld', 14:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:26 INFO - 'XPC_FLAGS': '0x0', 14:04:26 INFO - 'XPC_SERVICE_NAME': '0', 14:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:26 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-e9i9_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:26 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)) 14:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:26 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-uouhi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:26 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)) 14:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:26 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vjr3rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:26 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)) 14:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:26 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wdwjlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:26 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)) 14:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:26 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rOPrnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-fRlCMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-UyKJEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xqHP_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-SK7hx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-XdnImK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-GYbeTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xM7CZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-nWH3SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-5wD3JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:27 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)) 14:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:27 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-3_55Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:28 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)) 14:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:28 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Zc6Qaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:28 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)) 14:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:28 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-t5_A6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:28 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)) 14:04:28 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)) 14:04:28 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)) 14:04:28 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)) 14:04:28 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)) 14:04:28 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)) 14:04:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:28 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 14:04:28 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 14:04:28 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 14:04:28 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 14:04:28 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 14:04:28 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 14:04:30 INFO - Downloading blessings-1.6.tar.gz 14:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:30 INFO - Installing collected packages: blessings 14:04:30 INFO - Running setup.py install for blessings 14:04:31 INFO - Successfully installed blessings 14:04:31 INFO - Cleaning up... 14:04:31 INFO - Return code: 0 14:04:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:04:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:31 INFO - Reading from file tmpfile_stdout 14:04:31 INFO - Current package versions: 14:04:31 INFO - blessings == 1.6 14:04:31 INFO - blobuploader == 1.2.4 14:04:31 INFO - docopt == 0.6.1 14:04:31 INFO - functools32 == 3.2.3-2 14:04:31 INFO - jsonschema == 2.5.1 14:04:31 INFO - manifestparser == 1.1 14:04:31 INFO - mozInstall == 1.12 14:04:31 INFO - mozcrash == 0.17 14:04:31 INFO - mozdebug == 0.1 14:04:31 INFO - mozdevice == 0.48 14:04:31 INFO - mozfile == 1.2 14:04:31 INFO - mozhttpd == 0.7 14:04:31 INFO - mozinfo == 0.9 14:04:31 INFO - mozleak == 0.1 14:04:31 INFO - mozlog == 3.4 14:04:31 INFO - moznetwork == 0.27 14:04:31 INFO - mozprocess == 0.23 14:04:31 INFO - mozprofile == 0.28 14:04:31 INFO - mozrunner == 6.12 14:04:31 INFO - mozscreenshot == 0.1 14:04:31 INFO - mozsystemmonitor == 0.3 14:04:31 INFO - moztest == 0.7 14:04:31 INFO - mozversion == 1.4 14:04:31 INFO - psutil == 3.1.1 14:04:31 INFO - requests == 1.2.3 14:04:31 INFO - wsgiref == 0.1.2 14:04:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:31 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')]} 14:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:31 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')]} 14:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:31 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:31 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 14:04:31 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 14:04:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:31 INFO - 'HOME': '/Users/cltbld', 14:04:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:31 INFO - 'LOGNAME': 'cltbld', 14:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:31 INFO - 'MOZ_NO_REMOTE': '1', 14:04:31 INFO - 'NO_EM_RESTART': '1', 14:04:31 INFO - 'PAGER': '/bin/cat', 14:04:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:31 INFO - 'PWD': '/builds/slave/test', 14:04:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:31 INFO - 'SHELL': '/bin/bash', 14:04:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:31 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:31 INFO - 'USER': 'cltbld', 14:04:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:31 INFO - 'XPC_FLAGS': '0x0', 14:04:31 INFO - 'XPC_SERVICE_NAME': '0', 14:04:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 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)) 14:04:32 INFO - Cleaning up... 14:04:32 INFO - Return code: 0 14:04:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:04:32 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')]} 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:32 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')]} 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:32 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 0x10f4ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f423570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95514840b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, '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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 14:04:32 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 14:04:32 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 14:04:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:04:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:32 INFO - 'HOME': '/Users/cltbld', 14:04:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:32 INFO - 'LOGNAME': 'cltbld', 14:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:32 INFO - 'MOZ_NO_REMOTE': '1', 14:04:32 INFO - 'NO_EM_RESTART': '1', 14:04:32 INFO - 'PAGER': '/bin/cat', 14:04:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:32 INFO - 'PWD': '/builds/slave/test', 14:04:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:32 INFO - 'SHELL': '/bin/bash', 14:04:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:04:32 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:04:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:32 INFO - 'USER': 'cltbld', 14:04:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:32 INFO - 'XPC_FLAGS': '0x0', 14:04:32 INFO - 'XPC_SERVICE_NAME': '0', 14:04:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:04:32 INFO - Cleaning up... 14:04:32 INFO - Return code: 0 14:04:32 INFO - Running post-action listener: _resource_record_post_action 14:04:32 INFO - Running post-action listener: _start_resource_monitoring 14:04:32 INFO - Starting resource monitoring. 14:04:32 INFO - [mozharness: 2016-10-04 21:04:32.374485Z] Finished create-virtualenv step (success) 14:04:32 INFO - [mozharness: 2016-10-04 21:04:32.375449Z] Running install step. 14:04:32 INFO - Running pre-action listener: _resource_record_pre_action 14:04:32 INFO - Running main action method: install 14:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:32 INFO - Reading from file tmpfile_stdout 14:04:32 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:04:32 INFO - Reading from file tmpfile_stdout 14:04:32 INFO - Output received: 14:04:32 INFO - Usage: mozinstall [options] installer 14:04:32 INFO - Options: 14:04:32 INFO - -h, --help show this help message and exit 14:04:32 INFO - -d DEST, --destination=DEST 14:04:32 INFO - Directory to install application into. [default: 14:04:32 INFO - "/builds/slave/test"] 14:04:32 INFO - --app=APP Application being installed. [default: firefox] 14:04:32 INFO - mkdir: /builds/slave/test/build/application 14:04:32 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'] 14:04:32 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 14:05:05 INFO - Reading from file tmpfile_stdout 14:05:05 INFO - Output received: 14:05:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:05:05 INFO - Running post-action listener: _resource_record_post_action 14:05:05 INFO - [mozharness: 2016-10-04 21:05:05.097785Z] Finished install step (success) 14:05:05 INFO - [mozharness: 2016-10-04 21:05:05.097933Z] Running run-tests step. 14:05:05 INFO - Running pre-action listener: _resource_record_pre_action 14:05:05 INFO - Running main action method: run_tests 14:05:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:05:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:05:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:05:05 INFO - 2016-10-04 14:05:05.112 screenresolution[1645:7689] starting screenresolution argv=screenresolution get 14:05:05 INFO - 2016-10-04 14:05:05.115 screenresolution[1645:7689] Display 0: 1600x1200x32@60 14:05:05 INFO - 2016-10-04 14:05:05.120 screenresolution[1646:7692] starting screenresolution argv=screenresolution list 14:05:05 INFO - Available Modes on Display 0 14:05:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:05:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:05:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:05:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:05:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:05:05 INFO - Intel Iris: 14:05:05 INFO - Chipset Model: Intel Iris 14:05:05 INFO - Type: GPU 14:05:05 INFO - Bus: Built-In 14:05:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:05:05 INFO - Vendor: Intel (0x8086) 14:05:05 INFO - Device ID: 0x0a2e 14:05:05 INFO - Revision ID: 0x0009 14:05:05 INFO - Displays: 14:05:05 INFO - Display: 14:05:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:05:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:05:05 INFO - Display Serial Number: 1600x1200 60 14:05:05 INFO - Main Display: Yes 14:05:05 INFO - Mirror: Off 14:05:05 INFO - Online: Yes 14:05:05 INFO - Rotation: Supported 14:05:05 INFO - Return code: 0 14:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:05:05 INFO - Python 2.7.3 14:05:05 INFO - Return code: 0 14:05:05 INFO - grabbing minidump binary from tooltool 14:05:05 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')]} 14:05:05 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 0x10f2c1d30>, '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 0x10f127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:05:05 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 14:05:05 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 14:05:05 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 14:05:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:05 INFO - Return code: 0 14:05:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:05:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:05:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:05:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:05:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:05:05 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:05:05 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dfGbK8vMa3/Render', 14:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:05 INFO - 'HOME': '/Users/cltbld', 14:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:05 INFO - 'LOGNAME': 'cltbld', 14:05:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:05:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:05 INFO - 'MOZ_NO_REMOTE': '1', 14:05:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:05:05 INFO - 'NO_EM_RESTART': '1', 14:05:05 INFO - 'PAGER': '/bin/cat', 14:05:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:05 INFO - 'PWD': '/builds/slave/test', 14:05:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:05 INFO - 'SHELL': '/bin/bash', 14:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtVzaLNpAi/Listeners', 14:05:05 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 14:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:05 INFO - 'USER': 'cltbld', 14:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:05 INFO - 'XPC_FLAGS': '0x0', 14:05:05 INFO - 'XPC_SERVICE_NAME': '0', 14:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:05:05 INFO - mozversion application_buildid: 20161004115303 14:05:05 INFO - mozversion application_changeset: 2e84262d3d0d8eb3a3f415387b3bd562c2831184 14:05:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:05:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:05 INFO - mozversion application_name: Firefox 14:05:05 INFO - mozversion application_remotingname: firefox-dev 14:05:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:05 INFO - mozversion application_vendor: Mozilla 14:05:05 INFO - mozversion application_version: 51.0a2 14:05:05 INFO - mozversion platform_buildid: 20161004115303 14:05:05 INFO - mozversion platform_changeset: 2e84262d3d0d8eb3a3f415387b3bd562c2831184 14:05:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:05 INFO - mozversion platform_version: 51.0a2 14:05:05 INFO - using testdate: 1475615105 14:05:05 INFO - actual date: 1475615105 14:05:05 INFO - starting webserver on 'localhost:49283' 14:05:05 INFO - SUITE-START | Running 2 tests 14:05:05 INFO - TEST-START | dromaeo_css 14:05:05 INFO - operating with platform_type : mac_ 14:05:05 INFO - Initialising browser for dromaeo_css test... 14:05:05 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpCw1xrq/profile http://localhost:49283/getInfo.html) 14:05:08 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:05:08 INFO - PROCESS | 1656 | colorDepth:24 14:05:08 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:05:08 INFO - PROCESS | 1656 | __metrics 14:05:08 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:05:08 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:08 INFO - TEST-INFO | 1656: exit 0 14:05:08 INFO - Browser initialized. 14:05:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:08 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpCw1xrq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:20 INFO - PROCESS | 1658 | RSS: Main: 218890240 14:05:20 INFO - PROCESS | 1658 | 14:06:12 INFO - PROCESS | 1658 | 1475615172273 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] 14:08:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 14:08:25 INFO - PROCESS | 1658 | RSS: Main: 364204032 14:08:25 INFO - PROCESS | 1658 | 14:11:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 14:11:29 INFO - PROCESS | 1658 | RSS: Main: 352878592 14:11:29 INFO - PROCESS | 1658 | 14:14:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 14:14:32 INFO - PROCESS | 1658 | RSS: Main: 349102080 14:14:32 INFO - PROCESS | 1658 | 14:17:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 14:17:35 INFO - PROCESS | 1658 | RSS: Main: 321601536 14:17:35 INFO - PROCESS | 1658 | 14:20:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 14:20:39 INFO - PROCESS | 1658 | RSS: Main: 310099968 14:20:39 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 14:23:42 INFO - PROCESS | 1658 | RSS: Main: 358973440 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | __start_tp_report 14:23:42 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:23:42 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:23:42 INFO - PROCESS | 1658 | |i|pagename|runs| 14:23:42 INFO - PROCESS | 1658 | |0;dojo.html;3306.818125003125;3323.08615130839;3356.228067544463;3359.647237040112;3391.3556424279386;5605.943940560594;5610.382857885629;5711.771529138835;5749.310082790061;5761.769529218832;5647.152927060943;5673.319201695792;5716.657000579969;5723.9713801431035;5737.885242295151;5169.1987741899875;5178.792848286064;5201.661891977019;5220.582353411718;5240.60695447841;5145.74271286436;5180.740962951837;5280.049591073605;5287.841364759063;5324.281222035033;5185.844424667247;5198.246254293125;5205.7397130143345;5223.425423203445;5255.290535777678;5233.188855727369;5247.422783493813;5247.947520524784;5253.921191182136;5288.788448462057;4410.80151393188;5153.871153221199;5219.269302297681;5239.842804715865;5264.42091369949;5571.749271282802;5589.804356847531;5629.408912064257;5639.351474580435;5698.259226300595;6192.411720886508;6256.78101266458;6292.937070629281;6295.811125666238;6296.559240853142;6270.905936410957;6357.93642063578;6360.173177486943;6366.108744775735;6378.043293506012;5668.971655141698;5673.035583950738;5710.800121995793;5798.507126894219;5817.680027598481;6284.402981716729;6292.2134733158355;6293.992961126198;6299.181106456132;6308.085327627468;5371.382291036581;5900.321463031721;6133.417325354084;6139.693015349215;6140.723667434976;6118.3755344619085;6207.317195108534;6233.625982441068;6298.7480500780375;6317.305096439388;6127.234095738033;6138.419052470195;6206.782762603378;6230.750769969241;6302.65335406557;5221.634485586049;6309.432151106423;6311.715972781236;6319.494440444753;6321.1150438938585;4954.702717836942;4974.0051989602225;4987.750612469362;4991.825286114969;4992.525710057539;4356.564343565681;4397.582229688174;4434.800433980414;4441.244988351988;4445.5776701213335;5794.82615521535;5820.563457740602;5824.912626310609;5847.912281315784;5850.882982340329;5282.709450980156;6300.21247344082;6310;6330.272018717815;6335.208098987627;5684.971575142181;5686.175504551817;5753.568482363839;5797.217375654317;5802.042662960649;5370.812021579226;5422.349318081855;5439.238506609078;5476.726163691799;5483.972580137153;6282.780102696383;6338.366163383625;6339.366063393623;6340.207474065742;6351.650659213603;6130.2030736004035;6273;6320.841978950379;6333.841653958688;6336.58812177207;6222.222222222223;6226.159468471698;6252.624842509464;6287.74849006053;6327.019312006646;6239.78160764371;6283.528735344776;6286.4342209201395;6288.905666414916;6293.37066293367;6216.502679785516;6336.524760642878;6347.365263473615;6357.682115894279;6357.682115894279;4896.583790377857;6001.129836173817;6065.514758819196;6102.298235702951;6171;6059.545534085049;6155.138280640804;6169.50643948474;6170.475509581735;6172.2901866284155;5136.8185317376465;5198.740062996911;5923.289205295392;5949.732262048132;5993;5890.293164820077;5982.52139828804;6067.878642427215;6086.178365920544;6118.816435506942;5876.529877609695;5910.261217347832;5949.881002379841;5988.951933411723;5993.880122397615 14:23:42 INFO - PROCESS | 1658 | |1;ext.html;460.4428641343974;477.57257254757013;499.99500004999965;525.5532797122444;537.5806870640902;25298.747012529868;33969.32061358771;40153.39769903454;41559.58440415591;41842.58157418425;42579.36130958038;42929.14141717164;43011.56988430115;43075.3538696919;43086;9535.761605959871;9731.124198822105;9738.707838764849;9739.366941148803;9739.805203895918;8621.180987806149;8760.737177884641;9595.80808383832;11907.464164112593;12138.968187704011;11922.225055371373;11971.521139154424;11985.880141198608;11998.220115692495;12001.699957501045;11802.409879506076;11993.520259189665;12089.879101208964;12091.879081209163;12111.576094836682;11857.051435885194;11893.643190704293;11906.642800715992;11932;11936;39491.802540987395;39828.800855995825;39831.60168398337;39836.004099897735;39847;3288.5067239913965;3425.811580363079;3838.808059597009;3932.193900250442;3971.1263522025397;29808.70191298081;29848.104556863327;29865.55201671977;31625.20936976594;31760;3143.7956532825524;3246.626637936644;3263.2005158736024;3387.8814241501427;3393.9490907636405;367786.9999999973;372047;374111;374457;379906;33594.832025839714;34124.658753412645;34208.82895585506;35410.645893540735;61089;35494.290114197574;35579.82210088933;35583.82208088995;35630.821845890605;35686.10784730351;15007.399704011717;15152.696946061016;15162;15177;15185.240737963057;11691.356975366436;12802.935985320013;12905.290209038592;12906.483740650268;12915.741685166431;7224.530405523624;7366.96316518414;7609.353204977529;7769.53382797034;7869.055713314325;3189.5853539039776;3198;3245.172481017373;3254.5118232264876;3278.60656721195;941.9717408477757;948.8149810786969;1016.7254841192985;1031.200819364998;1145.6677563506657;25261.62107568388;29548.113556593336;29747;30028;30603.540946885816;1041.401194313273;1043.2280112716535;1066.168388656849;1107.4628805029554;1138.7950168969664;12743.745125097446;14078.859211407755;14871.33079011447;15401.845981540266;15804.920975395049;723759;727596;728489;729818;988263;46644;47849.5215047852;58044.709776451695;58191;62011.37988620147;1347.8854297384637;1364.3723887011888;1389.541451321082;1392.7980442835733;1393.038803225771;29674.55488167636;30630.387392252476;30658.080257591417;30746.538801918436;31514.842425787723;50497.495025050746;51422.48577514177;51428.742856286975;51594.22608660948;51670.48329516657;549338.7599185936;640090;643148;643830;646022;25148.62277065882;25989.090381836544;26591.069312573967;26601.33496662599;26691;46009.30986035279;46384.53615463802;46402;46987;47106.293405598255;31486.685133148374;37806.054848629006;38422.423663644506;38972.83081507559;40231.1953760929;37698.81150594229;38345;38369.2326153481;38603.034924127125;38922.80538597289;36529.26941461209;36975;38175.42736859005;38219.42670859884;38250.617493824706;29986.95045673391;32079.518807218377;34056.61603687718;34315.76947498504;34787.13032174216;24482;25025.49949001046;25337.366565836;25707.742922571284;25795.742042579335 14:23:42 INFO - PROCESS | 1658 | |2;jquery.html;350.7632348164991;371.8085186129142;373.9065233691577;383.46506623260564;404.3005600311461;13030.283334416616;15371.231438428089;16234.999999999985;20705.482362940897;21375.786242137576;19772.50568735779;20170.193192272327;20640.89679551604;20685.27601533943;20918.372448826558;4939.765058735316;5812.622179558336;6070.908936365958;6074;6085.695715214244;5965.910511342333;6008.369121242272;6076.240469941257;6082.635041897501;6105.847353816168;5685.374608793029;5926.3184733755525;6002.039673652216;6020.187274717922;6028.517718582525;5867.55993300502;5925.911111333312;5936.287645482526;5938.732757025944;5940.34656187819;4966.8146015752955;5152.690838549662;5206.583473322125;5224.686518808883;5230.0585894539345;26172.607410888853;26740.59889101665;26787.33031674224;26971.325716857038;27257.72742272572;2267.8185745140513;2289.050044231642;2304.158981971585;2431.90272389106;2548.5412625727363;14604.196769177692;15844.920775396164;15924.363025478968;16025.439109631106;16075.758863617055;1843.0692500287269;1885.8585606079462;1892.687706528435;1906.4852489827808;1963.0381113254546;115814.42092789567;119849;120786.39606801998;122388.38805806002;123810;10579.206559508068;10662.626808061681;11137.554497819996;11143.609973651046;11322.094232461382;13970.930145349208;13974.371153297923;13979.930100349433;13984.510542130976;13988.230647314496;6990.545614535039;8811.603477843513;8840.778980525538;8965.910340896507;8987.056359082202;8935.776605584912;8991.685291014783;8994.685186018458;9128.224100951493;9148.542572871329;5910.438508341701;6457.806265812033;6700.329967003261;6780.186377634617;6808.2510923798345;1650.4553497345846;1715.9227834747467;1752.9657502073583;1799.4344919919492;1877.2115711401245;768.281656651033;944.2540393089382;953.9141477266941;956.0726095687172;961.1781926452921;20742.58514829725;22417.991190396144;22470.887645561666;22475.10099595998;22483.66274505884;968.9127978481971;982.0572250639324;986.2652324018652;1002.5739060899234;1011.6964910526959;10914.890851091546;11504.539818407336;11814.527418903319;11866.466009029615;11866.762664746657;595291;621499;627411;635334.8233258805;642838;69980.95028574576;76248.61875690587;76927.61536192283;123082;123490;910;934.0612684252283;954.6610953111684;954.9522523873917;988.7429268390126;15719;19484.220631174594;20295.69556456625;21172.941352931983;21308.57382852365;53206.46793532015;53365.19952200798;54083.18875216796;54140.45859541512;54151;66491.66754166198;67808.6609566949;69585.65207173931;70945.58108837692;72179;5664.461876121762;7277.272272772892;7290.854182916206;7987.241212084843;8067.556284404414;11857.288562686266;12657.177283476545;12761.93619031899;13101.27942963108;13194.34028298562;8857.778555536162;9277.582508786985;10583.576656933636;11142.27575207609;11331.886681133083;9596.70444489985;10532.999365060306;10859.51132199037;11001.1749118818;11576.01603863681;11313.20807543464;11322.094232461548;11486.770264594828;11742.00192983606;11799;6953.20038195614;7218.927810721825;7240.855182896418;7410.296021877913;7982.321502672338;9282.582283797381;11016.504257308601;11268.774624507629;11331.093512519143;11459.255148415326 14:23:42 INFO - PROCESS | 1658 | |3;mootools.html;1500.6623509710316;1520.680657062017;1700.7703959965402;1810.4749622609445;1872.7284543741166;8352.331813454924;8884.111588841113;8894.91105088949;8897.91102088979;8906.688265910694;7930.6034698265;8123.878141827862;8144.4298899077085;8614.698485553006;8658.826823463543;2378.512404956988;2420.5642984262827;2426.9393265168424;2427.854328740272;2434.7200071991683;2391.282615215437;2410.7348191698898;2428.1622840120217;2431.1612493689736;2434.1480481831304;2401.639754036891;2413.722421921475;2417.8791060446997;2424.8181386396004;2432.9391765205833;2381.2856143157155;2386.4630458146953;2395.940101497459;2403.2790162951046;2412.674288970984;2377.2749311459997;2391.844530105555;2396.988015059931;2400.3159099656514;2403.7860880255535;8855.822883542358;8864.601092950832;8946.776330591721;8963.238124759404;8971.013188549254;5248.107821670325;5394.676319420847;5409.540189083933;5411.080116380225;5415.566754659618;3530.382183117944;3647.2310929199316;3681.37416639172;3718.0704823794053;3768.4158955361963;1069.288922866293;1085.403028334413;1096.199774164864;1101.7631209290041;1117.1788735279563;12018.579349722717;12049.216800907912;12066.638000859988;12072.577459788952;12085.335306558136;4705.435824570437;4745.738984355825;4760.500147484534;4843.297721830315;4886.438059623118;10105.242106842017;10128.088472037552;10131.392116473035;10139.7465063374;10148.898511014942;5334.67991920486;5408.675479471166;5418.322709661293;5418.51233388989;5421.403645598981;4165.91668166635;4417.116576684676;4528.0943811237885;4851.0055438635;4959.925601115914;3942.15243722601;3960.0693836948294;4035.878923632296;4071.5749487679077;4072.75563466193;1276.5978716704208;1286.633309506786;1286.9163504372186;1299.616613099138;1307.6469353274563;766.9194734552904;869.9826003479895;899.9460032398077;909.4452384045727;920.7145784806731;5667.744951477193;5705.2012718219485;5781.479666830005;5959.791407300723;6133.018717005258;430.1182575719762;435.46437881405416;459.5106211884333;460.10279954089657;462.58829641618985;3796.772193668389;3885.825137868803;4024.1348110156455;4038.495188101487;4052.675785937118;10104.545295461721;10896.78206435867;11006.669799906016;11036.392998385167;11053;10230.130438912776;10749.925007499187;10780.730481737863;10969.396683182502;10988.450577471094;8011.719589814328;8419.873701894476;8421.536815475085;8434;8439.07170211264;5421.972890135524;5625.156226566048;5810.912836307374;6025.487833534199;6137.96931015342;10133.797324053625;10200.540975656262;10327.845082323922;10347.017033381817;10353.17174626013;9583.520823958635;10439.269251152651;10442.895571044497;10465.843012354668;10473.423961682181;6973.023776671372;7183.892241616484;7196.640167991684;7607.315341619281;7760.3403710685225;8188.426810123234;8272.793180170544;8418.831623367621;8561.957190214009;8587.82824343522;7408.37028852532;7434.962825186056;7581.241875812375;7623.161452240138;7724.806879828049;7366.263373662591;7467.6639551221415;7490.887636685345;7611.771646850603;7691.615419229128;6951.582905025512;7102.289771022856;7113.715451382094;7114.253003434565;7116.857662846817;4880.341153944314;4972.637996951419;4981.4022317320705;4997.400311962588;5082.364704411949;4913.557779799835;4971.527704868032;5020.47285035066;5092.337996060636;5098.107831129611 14:23:42 INFO - PROCESS | 1658 | |4;prototype.html;306.7499987510179;307.2380496369006;314.3932210833092;321.4294627037009;321.97907136036173;5350.785968561253;5434.510894019538;5436.293281873351;5436.411968101054;5455.699936503491;4715.740634265114;5026.4470908200165;5101.117868404349;5208.114620514521;5414.2928535732135;4090.754554726711;4104.270660011097;4108.404281379198;4144.979275103636;4153.41852140699;3148.2601588626653;3488.5639295088113;4022.678185745148;4087.4277601135864;4120.938185927213;3540.6990405815536;3731.776093434389;3892.4939757831444;4068.3490641497365;4115.238680844039;4010.9799451002705;4063.97968010161;4069.6744260459386;4085.55058943516;4087.4263408587613;3152.777292009128;3334.499825026241;3472.888675623801;3523.0487768302414;3580.15866271426;4467.341931550722;4919.655624106314;5085.440601533828;5098.903735696843;5145.614078944094;3973.98013009936;4256.59562341577;4567.383403240553;4597;4605.516420775837;5582.748776305036;5602.60781745278;5610.298712660918;5612.242347283105;5635.126555383922;3822.10180607557;3838.193979264358;3841.4237864320576;3842.4236364545263;3852.614738526153;4871.732054736988;5100.903305789236;5606.775728970836;5817.854553636151;5839.416058394211;3274.41321356126;3536.381133301662;3878.631530004645;3892.5718171001167;3915.4909861717792;3947.9013024674614;3973.8211780469946;3978.781167035841;3987.980060099739;3988.700847436454;4424.3142312941545;4550.2492088804975;4600.2869555218995;4625.519833653266;4639.420072490939;5626.887462250732;5627.43725627434;5643.379228284885;5661.773529058792;5670.8810154414905;1117.714628177586;1150.672058463334;1200.2918278215895;1338.7791014482696;1360.3538319298452;843.8734189871568;853.4580541356283;858.2705847716855;865.8657908024267;872.9607167677469;4837.806487740451;5278.023565640292;5295.841124766186;5356.812511562077;5383.842473868137;5157.742112894341;5613.578981576398;5818.970905145447;5866.240127961594;5902.2032025676845;4446.132624297803;4466.798994045275;4907.411110666742;5287.20691896211;5309.601779866525;2457.668214791016;3002.969970300269;3017.6571425715347;3040.5439184122115;3062.846857657108;5006.898482333881;5157.484251574888;5613.410591887875;5634.211210430543;5924.348321684612;4913.926291105637;5509.696966666872;5813.360530341659;5832.737526811219;5846.269216347957;5595.580331475075;5837.5038121758425;5842.766289348463;5865.35481097079;5927.288725352985;4567.680262381601;5547.722613869371;5665.603407761582;5775.393583673822;5840.970795145997;5323.893522129613;5757.740901659352;5763.337216220189;5775.624584402;5872.853178670567;5623.971880140737;5726.398728133486;5998.710277290404;6036.879262414815;6040.486558642565;3285.342931413679;3861.517310336208;3870.767753934773;3905.882823515299;3914.0801911551334;5140.504456969296;5564.887022595578;5807.912881306699;5828.329742079715;5894.852628684317;5309.867253318544;5683.943160568507;5736.827895163152;5756.30924289088;5761.711914404347;4738.744232778386;4779.713217206979;5647.09174774983;5668.886622267449;5715.342735585461;4152.314868046738;5495.5878309127775;5560;5585.804496842754;5586.385497595343;5202.216814004641;5396.055690254111;5690.829275121753;5711.685857277724;5739.368669446274;5279.920801188062;5520.641158324696;5576.358718747396;5602.562885144812;5655.6656544668585 14:23:42 INFO - PROCESS | 1658 | |5;yui.html;704.4575676728919;718.3570704219723;719.6941299947524;773.8568364852501;795.6658203554507;14941.925290373547;16291.837081629195;16321.673566528661;16344.75482867758;16345.918270408662;14779.482718104868;14804.925975370135;14863.405463781462;14895.329710163041;14909.701805963874;650.5283669339726;671.8152508060298;674.1775034457978;825.2572684583863;848.9278411335044;820.0897004325194;831.1231650608605;831.3307787231277;831.71721614651;833.8499070167368;882.2236431939916;884.0761404332455;884.4428010353469;884.4781578868466;884.7920738626418;689.9448044156455;711.590835269722;866.5580553917484;878.8110556230409;879.0769691823559;653.9673016349163;664.9567778094457;665.6904539389208;666.7899611622372;667.8397184675691;15249.161296128708;15325.540233793005;15331;15333.156676382794;15339.156346400943;13660.453581856715;13817;13899.583012509642;13928.651783705387;14067.36696848634;11873.465694043789;12424.316662583555;12478.625641230778;12711.55509557161;12940.288284144368;4550.38569793077;4595.540445955411;4716.669833111683;4739.170645137087;4770.546798054179;110809;115458.42270788677;116021.25968110401;118796;118842.40578797137;9723.416595004323;10140.543675534618;10267.383956962607;11131.666050018512;11149.72125696864;19901.900490497745;19908;19931.302404415776;19962.401127966183;19972.50068748293;7311.561306321638;7413.925860741324;7558.962205188939;7749.496282741604;8108.675652973815;4282.057947251599;4289.613934745826;4362.498312694017;4466.932996005063;4524.796384162721;2766.681831589353;3464.72282217422;3529.9294014119573;3598.784072955631;3762.172322089136;624.3101372982788;636.0935666674969;636.4081404293959;651.4365074210868;658.6937074260492;587.5769445998874;615.6521565315583;622.4024936061342;622.9688515574203;626.370497649859;8772.385932984758;8905.332100092519;8928.419652722552;9134.451932884049;9178.036306187754;588.7644942023139;610.3896103896104;616.309733098932;628.3716283716284;653.4837478392017;4394.428724265825;4418.3151611499625;4455.933161002587;4456.551620723213;4542.182407166676;151784;157146.21426892793;158563;158912;161111;119319;129469;130587.24966089531;130936;133123;110560.89439105667;113998.52856375978;114633.4268328653;116764;119730;7962.203779621991;8123.79690507742;8221.890044843869;8510.914890851012;8538.743837684879;46828.7658561705;60615.39384606097;61568.46078848065;62053;62583;60536.09195862154;73829;90259.54870225607;93415.13169736703;94149;10962.451877406258;11077.83383249268;11215.88784112181;11260.662180134608;11374.488148033524;12129.818052729393;12226.572069977863;12411.875881241072;12484.188527745668;13086.869131308566;12093.818592721293;12310.630681079223;12585;12611.991040716537;12643.431045603154;10103.848442273225;12240;12265.38673066361;12638.936805315914;12653.557125500563;11919.940400297943;12006.159568830099;13112.672183195114;13517;14064.929675351967;11287.887121128684;11570.884291157317;11614.88385116138;11794.29234245948;12102.939485302517;11437.942810285895;11490.425478725863;11574.421278936188;11707.356095414834;11799.76400472003 14:23:42 INFO - PROCESS | 1658 | __end_tp_report 14:23:42 INFO - PROCESS | 1658 | __start_cc_report 14:23:42 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1373 14:23:42 INFO - PROCESS | 1658 | __end_cc_report 14:23:42 INFO - PROCESS | 1658 | __startTimestamp1475616222607__endTimestamp 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:23:42 INFO - PROCESS | 1658 | Number of tests: 6 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5728.59 Median:5890.29 stddev:659.10 (11.2%) stddev-sans-first:633.15 14:23:42 INFO - PROCESS | 1658 | Values: 3306.8 3323.1 3356.2 3359.6 3391.4 5605.9 5610.4 5711.8 5749.3 5761.8 5647.2 5673.3 5716.7 5724.0 5737.9 5169.2 5178.8 5201.7 5220.6 5240.6 5145.7 5180.7 5280.0 5287.8 5324.3 5185.8 5198.2 5205.7 5223.4 5255.3 5233.2 5247.4 5247.9 5253.9 5288.8 4410.8 5153.9 5219.3 5239.8 5264.4 5571.7 5589.8 5629.4 5639.4 5698.3 6192.4 6256.8 6292.9 6295.8 6296.6 6270.9 6357.9 6360.2 6366.1 6378.0 5669.0 5673.0 5710.8 5798.5 5817.7 6284.4 6292.2 6294.0 6299.2 6308.1 5371.4 5900.3 6133.4 6139.7 6140.7 6118.4 6207.3 6233.6 6298.7 6317.3 6127.2 6138.4 6206.8 6230.8 6302.7 5221.6 6309.4 6311.7 6319.5 6321.1 4954.7 4974.0 4987.8 4991.8 4992.5 4356.6 4397.6 4434.8 4441.2 4445.6 5794.8 5820.6 5824.9 5847.9 5850.9 5282.7 6300.2 6310.0 6330.3 6335.2 5685.0 5686.2 5753.6 5797.2 5802.0 5370.8 5422.3 5439.2 5476.7 5484.0 6282.8 6338.4 6339.4 6340.2 6351.7 6130.2 6273.0 6320.8 6333.8 6336.6 6222.2 6226.2 6252.6 6287.7 6327.0 6239.8 6283.5 6286.4 6288.9 6293.4 6216.5 6336.5 6347.4 6357.7 6357.7 4896.6 6001.1 6065.5 6102.3 6171.0 6059.5 6155.1 6169.5 6170.5 6172.3 5136.8 5198.7 5923.3 5949.7 5993.0 5890.3 5982.5 6067.9 6086.2 6118.8 5876.5 5910.3 5949.9 5989.0 5993.9 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:70356.38 Median:18870.79 stddev:166949.71 (884.7%) stddev-sans-first:167335.57 14:23:42 INFO - PROCESS | 1658 | Values: 460.4 477.6 500.0 525.6 537.6 25298.7 33969.3 40153.4 41559.6 41842.6 42579.4 42929.1 43011.6 43075.4 43086.0 9535.8 9731.1 9738.7 9739.4 9739.8 8621.2 8760.7 9595.8 11907.5 12139.0 11922.2 11971.5 11985.9 11998.2 12001.7 11802.4 11993.5 12089.9 12091.9 12111.6 11857.1 11893.6 11906.6 11932.0 11936.0 39491.8 39828.8 39831.6 39836.0 39847.0 3288.5 3425.8 3838.8 3932.2 3971.1 29808.7 29848.1 29865.6 31625.2 31760.0 3143.8 3246.6 3263.2 3387.9 3393.9 367787.0 372047.0 374111.0 374457.0 379906.0 33594.8 34124.7 34208.8 35410.6 61089.0 35494.3 35579.8 35583.8 35630.8 35686.1 15007.4 15152.7 15162.0 15177.0 15185.2 11691.4 12802.9 12905.3 12906.5 12915.7 7224.5 7367.0 7609.4 7769.5 7869.1 3189.6 3198.0 3245.2 3254.5 3278.6 942.0 948.8 1016.7 1031.2 1145.7 25261.6 29548.1 29747.0 30028.0 30603.5 1041.4 1043.2 1066.2 1107.5 1138.8 12743.7 14078.9 14871.3 15401.8 15804.9 723759.0 727596.0 728489.0 729818.0 988263.0 46644.0 47849.5 58044.7 58191.0 62011.4 1347.9 1364.4 1389.5 1392.8 1393.0 29674.6 30630.4 30658.1 30746.5 31514.8 50497.5 51422.5 51428.7 51594.2 51670.5 549338.8 640090.0 643148.0 643830.0 646022.0 25148.6 25989.1 26591.1 26601.3 26691.0 46009.3 46384.5 46402.0 46987.0 47106.3 31486.7 37806.1 38422.4 38972.8 40231.2 37698.8 38345.0 38369.2 38603.0 38922.8 36529.3 36975.0 38175.4 38219.4 38250.6 29987.0 32079.5 34056.6 34315.8 34787.1 24482.0 25025.5 25337.4 25707.7 25795.7 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:34820.89 Median:361.29 stddev:103349.30 (28606.0%) stddev-sans-first:103606.81 14:23:42 INFO - PROCESS | 1658 | Values: 350.8 371.8 373.9 383.5 404.3 13030.3 15371.2 16235.0 20705.5 21375.8 19772.5 20170.2 20640.9 20685.3 20918.4 4939.8 5812.6 6070.9 6074.0 6085.7 5965.9 6008.4 6076.2 6082.6 6105.8 5685.4 5926.3 6002.0 6020.2 6028.5 5867.6 5925.9 5936.3 5938.7 5940.3 4966.8 5152.7 5206.6 5224.7 5230.1 26172.6 26740.6 26787.3 26971.3 27257.7 2267.8 2289.1 2304.2 2431.9 2548.5 14604.2 15844.9 15924.4 16025.4 16075.8 1843.1 1885.9 1892.7 1906.5 1963.0 115814.4 119849.0 120786.4 122388.4 123810.0 10579.2 10662.6 11137.6 11143.6 11322.1 13970.9 13974.4 13979.9 13984.5 13988.2 6990.5 8811.6 8840.8 8965.9 8987.1 8935.8 8991.7 8994.7 9128.2 9148.5 5910.4 6457.8 6700.3 6780.2 6808.3 1650.5 1715.9 1753.0 1799.4 1877.2 768.3 944.3 953.9 956.1 961.2 20742.6 22418.0 22470.9 22475.1 22483.7 968.9 982.1 986.3 1002.6 1011.7 10914.9 11504.5 11814.5 11866.5 11866.8 595291.0 621499.0 627411.0 635334.8 642838.0 69981.0 76248.6 76927.6 123082.0 123490.0 910.0 934.1 954.7 955.0 988.7 15719.0 19484.2 20295.7 21172.9 21308.6 53206.5 53365.2 54083.2 54140.5 54151.0 66491.7 67808.7 69585.7 70945.6 72179.0 5664.5 7277.3 7290.9 7987.2 8067.6 11857.3 12657.2 12761.9 13101.3 13194.3 8857.8 9277.6 10583.6 11142.3 11331.9 9596.7 10533.0 10859.5 11001.2 11576.0 11313.2 11322.1 11486.8 11742.0 11799.0 6953.2 7218.9 7240.9 7410.3 7982.3 9282.6 11016.5 11268.8 11331.1 11459.3 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5762.43 Median:461.35 stddev:3265.57 (707.8%) stddev-sans-first:3259.02 14:23:42 INFO - PROCESS | 1658 | Values: 1500.7 1520.7 1700.8 1810.5 1872.7 8352.3 8884.1 8894.9 8897.9 8906.7 7930.6 8123.9 8144.4 8614.7 8658.8 2378.5 2420.6 2426.9 2427.9 2434.7 2391.3 2410.7 2428.2 2431.2 2434.1 2401.6 2413.7 2417.9 2424.8 2432.9 2381.3 2386.5 2395.9 2403.3 2412.7 2377.3 2391.8 2397.0 2400.3 2403.8 8855.8 8864.6 8946.8 8963.2 8971.0 5248.1 5394.7 5409.5 5411.1 5415.6 3530.4 3647.2 3681.4 3718.1 3768.4 1069.3 1085.4 1096.2 1101.8 1117.2 12018.6 12049.2 12066.6 12072.6 12085.3 4705.4 4745.7 4760.5 4843.3 4886.4 10105.2 10128.1 10131.4 10139.7 10148.9 5334.7 5408.7 5418.3 5418.5 5421.4 4165.9 4417.1 4528.1 4851.0 4959.9 3942.2 3960.1 4035.9 4071.6 4072.8 1276.6 1286.6 1286.9 1299.6 1307.6 766.9 870.0 899.9 909.4 920.7 5667.7 5705.2 5781.5 5959.8 6133.0 430.1 435.5 459.5 460.1 462.6 3796.8 3885.8 4024.1 4038.5 4052.7 10104.5 10896.8 11006.7 11036.4 11053.0 10230.1 10749.9 10780.7 10969.4 10988.5 8011.7 8419.9 8421.5 8434.0 8439.1 5422.0 5625.2 5810.9 6025.5 6138.0 10133.8 10200.5 10327.8 10347.0 10353.2 9583.5 10439.3 10442.9 10465.8 10473.4 6973.0 7183.9 7196.6 7607.3 7760.3 8188.4 8272.8 8418.8 8562.0 8587.8 7408.4 7435.0 7581.2 7623.2 7724.8 7366.3 7467.7 7490.9 7611.8 7691.6 6951.6 7102.3 7113.7 7114.3 7116.9 4880.3 4972.6 4981.4 4997.4 5082.4 4913.6 4971.5 5020.5 5092.3 5098.1 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4545.71 Median:5151.55 stddev:1413.72 (27.4%) stddev-sans-first:1381.42 14:23:42 INFO - PROCESS | 1658 | Values: 306.7 307.2 314.4 321.4 322.0 5350.8 5434.5 5436.3 5436.4 5455.7 4715.7 5026.4 5101.1 5208.1 5414.3 4090.8 4104.3 4108.4 4145.0 4153.4 3148.3 3488.6 4022.7 4087.4 4120.9 3540.7 3731.8 3892.5 4068.3 4115.2 4011.0 4064.0 4069.7 4085.6 4087.4 3152.8 3334.5 3472.9 3523.0 3580.2 4467.3 4919.7 5085.4 5098.9 5145.6 3974.0 4256.6 4567.4 4597.0 4605.5 5582.7 5602.6 5610.3 5612.2 5635.1 3822.1 3838.2 3841.4 3842.4 3852.6 4871.7 5100.9 5606.8 5817.9 5839.4 3274.4 3536.4 3878.6 3892.6 3915.5 3947.9 3973.8 3978.8 3988.0 3988.7 4424.3 4550.2 4600.3 4625.5 4639.4 5626.9 5627.4 5643.4 5661.8 5670.9 1117.7 1150.7 1200.3 1338.8 1360.4 843.9 853.5 858.3 865.9 873.0 4837.8 5278.0 5295.8 5356.8 5383.8 5157.7 5613.6 5819.0 5866.2 5902.2 4446.1 4466.8 4907.4 5287.2 5309.6 2457.7 3003.0 3017.7 3040.5 3062.8 5006.9 5157.5 5613.4 5634.2 5924.3 4913.9 5509.7 5813.4 5832.7 5846.3 5595.6 5837.5 5842.8 5865.4 5927.3 4567.7 5547.7 5665.6 5775.4 5841.0 5323.9 5757.7 5763.3 5775.6 5872.9 5624.0 5726.4 5998.7 6036.9 6040.5 3285.3 3861.5 3870.8 3905.9 3914.1 5140.5 5564.9 5807.9 5828.3 5894.9 5309.9 5683.9 5736.8 5756.3 5761.7 4738.7 4779.7 5647.1 5668.9 5715.3 4152.3 5495.6 5560.0 5585.8 5586.4 5202.2 5396.1 5690.8 5711.7 5739.4 5279.9 5520.6 5576.4 5602.6 5655.7 14:23:42 INFO - PROCESS | 1658 | 14:23:42 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24836.28 Median:3497.33 stddev:40682.05 (1163.2%) stddev-sans-first:40755.82 14:23:42 INFO - PROCESS | 1658 | Values: 704.5 718.4 719.7 773.9 795.7 14941.9 16291.8 16321.7 16344.8 16345.9 14779.5 14804.9 14863.4 14895.3 14909.7 650.5 671.8 674.2 825.3 848.9 820.1 831.1 831.3 831.7 833.8 882.2 884.1 884.4 884.5 884.8 689.9 711.6 866.6 878.8 879.1 654.0 665.0 665.7 666.8 667.8 15249.2 15325.5 15331.0 15333.2 15339.2 13660.5 13817.0 13899.6 13928.7 14067.4 11873.5 12424.3 12478.6 12711.6 12940.3 4550.4 4595.5 4716.7 4739.2 4770.5 110809.0 115458.4 116021.3 118796.0 118842.4 9723.4 10140.5 10267.4 11131.7 11149.7 19901.9 19908.0 19931.3 19962.4 19972.5 7311.6 7413.9 7559.0 7749.5 8108.7 4282.1 4289.6 4362.5 4466.9 4524.8 2766.7 3464.7 3529.9 3598.8 3762.2 624.3 636.1 636.4 651.4 658.7 587.6 615.7 622.4 623.0 626.4 8772.4 8905.3 8928.4 9134.5 9178.0 588.8 610.4 616.3 628.4 653.5 4394.4 4418.3 4455.9 4456.6 4542.2 151784.0 157146.2 158563.0 158912.0 161111.0 119319.0 129469.0 130587.2 130936.0 133123.0 110560.9 113998.5 114633.4 116764.0 119730.0 7962.2 8123.8 8221.9 8510.9 8538.7 46828.8 60615.4 61568.5 62053.0 62583.0 60536.1 73829.0 90259.5 93415.1 94149.0 10962.5 11077.8 11215.9 11260.7 11374.5 12129.8 12226.6 12411.9 12484.2 13086.9 12093.8 12310.6 12585.0 12612.0 12643.4 10103.8 12240.0 12265.4 12638.9 12653.6 11919.9 12006.2 13112.7 13517.0 14064.9 11287.9 11570.9 11614.9 11794.3 12102.9 11437.9 11490.4 11574.4 11707.4 11799.8 14:23:42 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:23:42 INFO - PROCESS | 1658 | 14:23:43 INFO - TEST-INFO | 1658: exit 0 14:23:43 INFO - TEST-OK | dromaeo_css | took 1117510ms 14:23:43 INFO - TEST-START | kraken 14:23:43 INFO - operating with platform_type : mac_ 14:23:43 INFO - Initialising browser for kraken test... 14:23:43 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpV5JLy5/profile http://localhost:49283/getInfo.html) 14:23:45 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 14:23:45 INFO - PROCESS | 1665 | colorDepth:24 14:23:45 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 14:23:45 INFO - PROCESS | 1665 | __metrics 14:23:45 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:23:45 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:46 INFO - TEST-INFO | 1665: exit 0 14:23:46 INFO - Browser initialized. 14:23:46 INFO - Running cycle 1/1 for kraken test... 14:23:46 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpV5JLy5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:58 INFO - PROCESS | 1666 | RSS: Main: 219549696 14:23:58 INFO - PROCESS | 1666 | 14:24:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:02 INFO - PROCESS | 1666 | RSS: Main: 269373440 14:24:02 INFO - PROCESS | 1666 | 14:24:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 14:24:05 INFO - PROCESS | 1666 | RSS: Main: 279846912 14:24:05 INFO - PROCESS | 1666 | 14:24:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 14:24:09 INFO - PROCESS | 1666 | RSS: Main: 375902208 14:24:09 INFO - PROCESS | 1666 | 14:24:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 14:24:11 INFO - PROCESS | 1666 | RSS: Main: 279605248 14:24:11 INFO - PROCESS | 1666 | 14:24:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:14 INFO - PROCESS | 1666 | RSS: Main: 280821760 14:24:14 INFO - PROCESS | 1666 | 14:24:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:17 INFO - PROCESS | 1666 | RSS: Main: 319668224 14:24:17 INFO - PROCESS | 1666 | 14:24:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:21 INFO - PROCESS | 1666 | RSS: Main: 318910464 14:24:21 INFO - PROCESS | 1666 | 14:24:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 14:24:24 INFO - PROCESS | 1666 | RSS: Main: 317845504 14:24:24 INFO - PROCESS | 1666 | 14:24:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:27 INFO - PROCESS | 1666 | RSS: Main: 289738752 14:24:27 INFO - PROCESS | 1666 | 14:24:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:29 INFO - PROCESS | 1666 | RSS: Main: 295538688 14:24:29 INFO - PROCESS | 1666 | 14:24:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:32 INFO - PROCESS | 1666 | RSS: Main: 303955968 14:24:32 INFO - PROCESS | 1666 | 14:24:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:36 INFO - PROCESS | 1666 | RSS: Main: 307511296 14:24:36 INFO - PROCESS | 1666 | 14:24:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:39 INFO - PROCESS | 1666 | RSS: Main: 308273152 14:24:39 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 14:24:41 INFO - PROCESS | 1666 | RSS: Main: 351920128 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | __start_tp_report 14:24:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 14:24:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 14:24:41 INFO - PROCESS | 1666 | |i|pagename|runs| 14:24:41 INFO - PROCESS | 1666 | |0;ai-astar;114;114;113;113;114;114;113;115;167;166 14:24:41 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;105;96;165;96;129;138;139;167;109 14:24:41 INFO - PROCESS | 1666 | |2;audio-dft;183;181;183;185;181;183;183;184;182;183 14:24:41 INFO - PROCESS | 1666 | |3;audio-fft;81;58;59;88;62;69;60;59;82;58 14:24:41 INFO - PROCESS | 1666 | |4;audio-oscillator;91;70;94;70;68;70;90;67;68;91 14:24:41 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;91;125;87;84;88;84;96;128;116;83 14:24:41 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;95;96;96;96;95;96;103;96;95 14:24:41 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;85;87;100;139;135;84;86;84;87 14:24:41 INFO - PROCESS | 1666 | |8;json-parse-financial;56;51;53;52;54;57;57;56;55;56 14:24:41 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;73;66;75;99;103;98;81;70;70;71 14:24:41 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;79;85;86;85;83;86;82;83;89;108 14:24:41 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;140;136;136;152;146;162;151;151;171;129 14:24:41 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;161;162;164;163;160;168;219;172;163 14:24:41 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;67;67;67;64;66;66;66;65;67 14:24:41 INFO - PROCESS | 1666 | __end_tp_report 14:24:41 INFO - PROCESS | 1666 | __start_cc_report 14:24:41 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1957 14:24:41 INFO - PROCESS | 1666 | __end_cc_report 14:24:41 INFO - PROCESS | 1666 | __startTimestamp1475616281641__endTimestamp 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | ------- Summary: start ------- 14:24:41 INFO - PROCESS | 1666 | Number of tests: 14 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:124.30 Median:114.00 stddev:22.25 (19.5%) stddev-sans-first:23.29 14:24:41 INFO - PROCESS | 1666 | Values: 114.0 114.0 113.0 113.0 114.0 114.0 113.0 115.0 167.0 166.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:155.00 stddev:26.52 (17.1%) stddev-sans-first:27.48 14:24:41 INFO - PROCESS | 1666 | Values: 145.0 105.0 96.0 165.0 96.0 129.0 138.0 139.0 167.0 109.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 14:24:41 INFO - PROCESS | 1666 | Values: 183.0 181.0 183.0 185.0 181.0 183.0 183.0 184.0 182.0 183.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:67.60 Median:65.50 stddev:11.67 (17.8%) stddev-sans-first:11.33 14:24:41 INFO - PROCESS | 1666 | Values: 81.0 58.0 59.0 88.0 62.0 69.0 60.0 59.0 82.0 58.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.00 stddev:11.79 (14.7%) stddev-sans-first:11.51 14:24:41 INFO - PROCESS | 1666 | Values: 91.0 70.0 94.0 70.0 68.0 70.0 90.0 67.0 68.0 91.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:85.50 stddev:17.78 (20.8%) stddev-sans-first:18.66 14:24:41 INFO - PROCESS | 1666 | Values: 91.0 125.0 87.0 84.0 88.0 84.0 96.0 128.0 116.0 83.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:2.41 (2.5%) stddev-sans-first:2.51 14:24:41 INFO - PROCESS | 1666 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 103.0 96.0 95.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:85.50 stddev:21.45 (25.1%) stddev-sans-first:22.36 14:24:41 INFO - PROCESS | 1666 | Values: 86.0 85.0 87.0 100.0 139.0 135.0 84.0 86.0 84.0 87.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:56.00 stddev:2.11 (3.8%) stddev-sans-first:2.19 14:24:41 INFO - PROCESS | 1666 | Values: 56.0 51.0 53.0 52.0 54.0 57.0 57.0 56.0 55.0 56.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:74.00 stddev:13.99 (18.9%) stddev-sans-first:14.57 14:24:41 INFO - PROCESS | 1666 | Values: 73.0 66.0 75.0 99.0 103.0 98.0 81.0 70.0 70.0 71.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:7.99 (9.4%) stddev-sans-first:7.99 14:24:41 INFO - PROCESS | 1666 | Values: 79.0 85.0 86.0 85.0 83.0 86.0 82.0 83.0 89.0 108.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:151.00 stddev:12.79 (8.5%) stddev-sans-first:13.28 14:24:41 INFO - PROCESS | 1666 | Values: 140.0 136.0 136.0 152.0 146.0 162.0 151.0 151.0 171.0 129.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:163.50 stddev:17.75 (10.9%) stddev-sans-first:18.67 14:24:41 INFO - PROCESS | 1666 | Values: 163.0 161.0 162.0 164.0 163.0 160.0 168.0 219.0 172.0 163.0 14:24:41 INFO - PROCESS | 1666 | 14:24:41 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 14:24:41 INFO - PROCESS | 1666 | Values: 67.0 67.0 67.0 67.0 64.0 66.0 66.0 66.0 65.0 67.0 14:24:41 INFO - PROCESS | 1666 | -------- Summary: end -------- 14:24:41 INFO - PROCESS | 1666 | 14:24:42 INFO - TEST-INFO | 1666: exit 0 14:24:42 INFO - TEST-OK | kraken | took 59265ms 14:24:42 INFO - SUITE-END | took 1176s 14:24:42 INFO - Completed test suite (00:19:37) 14:24:42 INFO - javascript benchmark 14:24:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.818125003125, 3323.08615130839, 3356.228067544463, 3359.647237040112, 3391.3556424279386, 5605.943940560594, 5610.382857885629, 5711.771529138835, 5749.310082790061, 5761.769529218832, 5647.152927060943, 5673.319201695792, 5716.657000579969, 5723.9713801431035, 5737.885242295151, 5169.1987741899875, 5178.792848286064, 5201.661891977019, 5220.582353411718, 5240.60695447841, 5145.74271286436, 5180.740962951837, 5280.049591073605, 5287.841364759063, 5324.281222035033, 5185.844424667247, 5198.246254293125, 5205.7397130143345, 5223.425423203445, 5255.290535777678, 5233.188855727369, 5247.422783493813, 5247.947520524784, 5253.921191182136, 5288.788448462057, 4410.80151393188, 5153.871153221199, 5219.269302297681, 5239.842804715865, 5264.42091369949, 5571.749271282802, 5589.804356847531, 5629.408912064257, 5639.351474580435, 5698.259226300595, 6192.411720886508, 6256.78101266458, 6292.937070629281, 6295.811125666238, 6296.559240853142, 6270.905936410957, 6357.93642063578, 6360.173177486943, 6366.108744775735, 6378.043293506012, 5668.971655141698, 5673.035583950738, 5710.800121995793, 5798.507126894219, 5817.680027598481, 6284.402981716729, 6292.2134733158355, 6293.992961126198, 6299.181106456132, 6308.085327627468, 5371.382291036581, 5900.321463031721, 6133.417325354084, 6139.693015349215, 6140.723667434976, 6118.3755344619085, 6207.317195108534, 6233.625982441068, 6298.7480500780375, 6317.305096439388, 6127.234095738033, 6138.419052470195, 6206.782762603378, 6230.750769969241, 6302.65335406557, 5221.634485586049, 6309.432151106423, 6311.715972781236, 6319.494440444753, 6321.1150438938585, 4954.702717836942, 4974.0051989602225, 4987.750612469362, 4991.825286114969, 4992.525710057539, 4356.564343565681, 4397.582229688174, 4434.800433980414, 4441.244988351988, 4445.5776701213335, 5794.82615521535, 5820.563457740602, 5824.912626310609, 5847.912281315784, 5850.882982340329, 5282.709450980156, 6300.21247344082, 6310.0, 6330.272018717815, 6335.208098987627, 5684.971575142181, 5686.175504551817, 5753.568482363839, 5797.217375654317, 5802.042662960649, 5370.812021579226, 5422.349318081855, 5439.238506609078, 5476.726163691799, 5483.972580137153, 6282.780102696383, 6338.366163383625, 6339.366063393623, 6340.207474065742, 6351.650659213603, 6130.2030736004035, 6273.0, 6320.841978950379, 6333.841653958688, 6336.58812177207, 6222.222222222223, 6226.159468471698, 6252.624842509464, 6287.74849006053, 6327.019312006646, 6239.78160764371, 6283.528735344776, 6286.4342209201395, 6288.905666414916, 6293.37066293367, 6216.502679785516, 6336.524760642878, 6347.365263473615, 6357.682115894279, 6357.682115894279, 4896.583790377857, 6001.129836173817, 6065.514758819196, 6102.298235702951, 6171.0, 6059.545534085049, 6155.138280640804, 6169.50643948474, 6170.475509581735, 6172.2901866284155, 5136.8185317376465, 5198.740062996911, 5923.289205295392, 5949.732262048132, 5993.0, 5890.293164820077, 5982.52139828804, 6067.878642427215, 6086.178365920544, 6118.816435506942, 5876.529877609695, 5910.261217347832, 5949.881002379841, 5988.951933411723, 5993.880122397615], "value": 5686.88479012946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.4428641343974, 477.57257254757013, 499.99500004999965, 525.5532797122444, 537.5806870640902, 25298.747012529868, 33969.32061358771, 40153.39769903454, 41559.58440415591, 41842.58157418425, 42579.36130958038, 42929.14141717164, 43011.56988430115, 43075.3538696919, 43086.0, 9535.761605959871, 9731.124198822105, 9738.707838764849, 9739.366941148803, 9739.805203895918, 8621.180987806149, 8760.737177884641, 9595.80808383832, 11907.464164112593, 12138.968187704011, 11922.225055371373, 11971.521139154424, 11985.880141198608, 11998.220115692495, 12001.699957501045, 11802.409879506076, 11993.520259189665, 12089.879101208964, 12091.879081209163, 12111.576094836682, 11857.051435885194, 11893.643190704293, 11906.642800715992, 11932.0, 11936.0, 39491.802540987395, 39828.800855995825, 39831.60168398337, 39836.004099897735, 39847.0, 3288.5067239913965, 3425.811580363079, 3838.808059597009, 3932.193900250442, 3971.1263522025397, 29808.70191298081, 29848.104556863327, 29865.55201671977, 31625.20936976594, 31760.0, 3143.7956532825524, 3246.626637936644, 3263.2005158736024, 3387.8814241501427, 3393.9490907636405, 367786.9999999973, 372047.0, 374111.0, 374457.0, 379906.0, 33594.832025839714, 34124.658753412645, 34208.82895585506, 35410.645893540735, 61089.0, 35494.290114197574, 35579.82210088933, 35583.82208088995, 35630.821845890605, 35686.10784730351, 15007.399704011717, 15152.696946061016, 15162.0, 15177.0, 15185.240737963057, 11691.356975366436, 12802.935985320013, 12905.290209038592, 12906.483740650268, 12915.741685166431, 7224.530405523624, 7366.96316518414, 7609.353204977529, 7769.53382797034, 7869.055713314325, 3189.5853539039776, 3198.0, 3245.172481017373, 3254.5118232264876, 3278.60656721195, 941.9717408477757, 948.8149810786969, 1016.7254841192985, 1031.200819364998, 1145.6677563506657, 25261.62107568388, 29548.113556593336, 29747.0, 30028.0, 30603.540946885816, 1041.401194313273, 1043.2280112716535, 1066.168388656849, 1107.4628805029554, 1138.7950168969664, 12743.745125097446, 14078.859211407755, 14871.33079011447, 15401.845981540266, 15804.920975395049, 723759.0, 727596.0, 728489.0, 729818.0, 988263.0, 46644.0, 47849.5215047852, 58044.709776451695, 58191.0, 62011.37988620147, 1347.8854297384637, 1364.3723887011888, 1389.541451321082, 1392.7980442835733, 1393.038803225771, 29674.55488167636, 30630.387392252476, 30658.080257591417, 30746.538801918436, 31514.842425787723, 50497.495025050746, 51422.48577514177, 51428.742856286975, 51594.22608660948, 51670.48329516657, 549338.7599185936, 640090.0, 643148.0, 643830.0, 646022.0, 25148.62277065882, 25989.090381836544, 26591.069312573967, 26601.33496662599, 26691.0, 46009.30986035279, 46384.53615463802, 46402.0, 46987.0, 47106.293405598255, 31486.685133148374, 37806.054848629006, 38422.423663644506, 38972.83081507559, 40231.1953760929, 37698.81150594229, 38345.0, 38369.2326153481, 38603.034924127125, 38922.80538597289, 36529.26941461209, 36975.0, 38175.42736859005, 38219.42670859884, 38250.617493824706, 29986.95045673391, 32079.518807218377, 34056.61603687718, 34315.76947498504, 34787.13032174216, 24482.0, 25025.49949001046, 25337.366565836, 25707.742922571284, 25795.742042579335], "value": 18783.880998135228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7632348164991, 371.8085186129142, 373.9065233691577, 383.46506623260564, 404.3005600311461, 13030.283334416616, 15371.231438428089, 16234.999999999985, 20705.482362940897, 21375.786242137576, 19772.50568735779, 20170.193192272327, 20640.89679551604, 20685.27601533943, 20918.372448826558, 4939.765058735316, 5812.622179558336, 6070.908936365958, 6074.0, 6085.695715214244, 5965.910511342333, 6008.369121242272, 6076.240469941257, 6082.635041897501, 6105.847353816168, 5685.374608793029, 5926.3184733755525, 6002.039673652216, 6020.187274717922, 6028.517718582525, 5867.55993300502, 5925.911111333312, 5936.287645482526, 5938.732757025944, 5940.34656187819, 4966.8146015752955, 5152.690838549662, 5206.583473322125, 5224.686518808883, 5230.0585894539345, 26172.607410888853, 26740.59889101665, 26787.33031674224, 26971.325716857038, 27257.72742272572, 2267.8185745140513, 2289.050044231642, 2304.158981971585, 2431.90272389106, 2548.5412625727363, 14604.196769177692, 15844.920775396164, 15924.363025478968, 16025.439109631106, 16075.758863617055, 1843.0692500287269, 1885.8585606079462, 1892.687706528435, 1906.4852489827808, 1963.0381113254546, 115814.42092789567, 119849.0, 120786.39606801998, 122388.38805806002, 123810.0, 10579.206559508068, 10662.626808061681, 11137.554497819996, 11143.609973651046, 11322.094232461382, 13970.930145349208, 13974.371153297923, 13979.930100349433, 13984.510542130976, 13988.230647314496, 6990.545614535039, 8811.603477843513, 8840.778980525538, 8965.910340896507, 8987.056359082202, 8935.776605584912, 8991.685291014783, 8994.685186018458, 9128.224100951493, 9148.542572871329, 5910.438508341701, 6457.806265812033, 6700.329967003261, 6780.186377634617, 6808.2510923798345, 1650.4553497345846, 1715.9227834747467, 1752.9657502073583, 1799.4344919919492, 1877.2115711401245, 768.281656651033, 944.2540393089382, 953.9141477266941, 956.0726095687172, 961.1781926452921, 20742.58514829725, 22417.991190396144, 22470.887645561666, 22475.10099595998, 22483.66274505884, 968.9127978481971, 982.0572250639324, 986.2652324018652, 1002.5739060899234, 1011.6964910526959, 10914.890851091546, 11504.539818407336, 11814.527418903319, 11866.466009029615, 11866.762664746657, 595291.0, 621499.0, 627411.0, 635334.8233258805, 642838.0, 69980.95028574576, 76248.61875690587, 76927.61536192283, 123082.0, 123490.0, 910.0, 934.0612684252283, 954.6610953111684, 954.9522523873917, 988.7429268390126, 15719.0, 19484.220631174594, 20295.69556456625, 21172.941352931983, 21308.57382852365, 53206.46793532015, 53365.19952200798, 54083.18875216796, 54140.45859541512, 54151.0, 66491.66754166198, 67808.6609566949, 69585.65207173931, 70945.58108837692, 72179.0, 5664.461876121762, 7277.272272772892, 7290.854182916206, 7987.241212084843, 8067.556284404414, 11857.288562686266, 12657.177283476545, 12761.93619031899, 13101.27942963108, 13194.34028298562, 8857.778555536162, 9277.582508786985, 10583.576656933636, 11142.27575207609, 11331.886681133083, 9596.70444489985, 10532.999365060306, 10859.51132199037, 11001.1749118818, 11576.01603863681, 11313.20807543464, 11322.094232461548, 11486.770264594828, 11742.00192983606, 11799.0, 6953.20038195614, 7218.927810721825, 7240.855182896418, 7410.296021877913, 7982.321502672338, 9282.582283797381, 11016.504257308601, 11268.774624507629, 11331.093512519143, 11459.255148415326], "value": 9604.024292631153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.6623509710316, 1520.680657062017, 1700.7703959965402, 1810.4749622609445, 1872.7284543741166, 8352.331813454924, 8884.111588841113, 8894.91105088949, 8897.91102088979, 8906.688265910694, 7930.6034698265, 8123.878141827862, 8144.4298899077085, 8614.698485553006, 8658.826823463543, 2378.512404956988, 2420.5642984262827, 2426.9393265168424, 2427.854328740272, 2434.7200071991683, 2391.282615215437, 2410.7348191698898, 2428.1622840120217, 2431.1612493689736, 2434.1480481831304, 2401.639754036891, 2413.722421921475, 2417.8791060446997, 2424.8181386396004, 2432.9391765205833, 2381.2856143157155, 2386.4630458146953, 2395.940101497459, 2403.2790162951046, 2412.674288970984, 2377.2749311459997, 2391.844530105555, 2396.988015059931, 2400.3159099656514, 2403.7860880255535, 8855.822883542358, 8864.601092950832, 8946.776330591721, 8963.238124759404, 8971.013188549254, 5248.107821670325, 5394.676319420847, 5409.540189083933, 5411.080116380225, 5415.566754659618, 3530.382183117944, 3647.2310929199316, 3681.37416639172, 3718.0704823794053, 3768.4158955361963, 1069.288922866293, 1085.403028334413, 1096.199774164864, 1101.7631209290041, 1117.1788735279563, 12018.579349722717, 12049.216800907912, 12066.638000859988, 12072.577459788952, 12085.335306558136, 4705.435824570437, 4745.738984355825, 4760.500147484534, 4843.297721830315, 4886.438059623118, 10105.242106842017, 10128.088472037552, 10131.392116473035, 10139.7465063374, 10148.898511014942, 5334.67991920486, 5408.675479471166, 5418.322709661293, 5418.51233388989, 5421.403645598981, 4165.91668166635, 4417.116576684676, 4528.0943811237885, 4851.0055438635, 4959.925601115914, 3942.15243722601, 3960.0693836948294, 4035.878923632296, 4071.5749487679077, 4072.75563466193, 1276.5978716704208, 1286.633309506786, 1286.9163504372186, 1299.616613099138, 1307.6469353274563, 766.9194734552904, 869.9826003479895, 899.9460032398077, 909.4452384045727, 920.7145784806731, 5667.744951477193, 5705.2012718219485, 5781.479666830005, 5959.791407300723, 6133.018717005258, 430.1182575719762, 435.46437881405416, 459.5106211884333, 460.10279954089657, 462.58829641618985, 3796.772193668389, 3885.825137868803, 4024.1348110156455, 4038.495188101487, 4052.675785937118, 10104.545295461721, 10896.78206435867, 11006.669799906016, 11036.392998385167, 11053.0, 10230.130438912776, 10749.925007499187, 10780.730481737863, 10969.396683182502, 10988.450577471094, 8011.719589814328, 8419.873701894476, 8421.536815475085, 8434.0, 8439.07170211264, 5421.972890135524, 5625.156226566048, 5810.912836307374, 6025.487833534199, 6137.96931015342, 10133.797324053625, 10200.540975656262, 10327.845082323922, 10347.017033381817, 10353.17174626013, 9583.520823958635, 10439.269251152651, 10442.895571044497, 10465.843012354668, 10473.423961682181, 6973.023776671372, 7183.892241616484, 7196.640167991684, 7607.315341619281, 7760.3403710685225, 8188.426810123234, 8272.793180170544, 8418.831623367621, 8561.957190214009, 8587.82824343522, 7408.37028852532, 7434.962825186056, 7581.241875812375, 7623.161452240138, 7724.806879828049, 7366.263373662591, 7467.6639551221415, 7490.887636685345, 7611.771646850603, 7691.615419229128, 6951.582905025512, 7102.289771022856, 7113.715451382094, 7114.253003434565, 7116.857662846817, 4880.341153944314, 4972.637996951419, 4981.4022317320705, 4997.400311962588, 5082.364704411949, 4913.557779799835, 4971.527704868032, 5020.47285035066, 5092.337996060636, 5098.107831129611], "value": 4549.183750906613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7499987510179, 307.2380496369006, 314.3932210833092, 321.4294627037009, 321.97907136036173, 5350.785968561253, 5434.510894019538, 5436.293281873351, 5436.411968101054, 5455.699936503491, 4715.740634265114, 5026.4470908200165, 5101.117868404349, 5208.114620514521, 5414.2928535732135, 4090.754554726711, 4104.270660011097, 4108.404281379198, 4144.979275103636, 4153.41852140699, 3148.2601588626653, 3488.5639295088113, 4022.678185745148, 4087.4277601135864, 4120.938185927213, 3540.6990405815536, 3731.776093434389, 3892.4939757831444, 4068.3490641497365, 4115.238680844039, 4010.9799451002705, 4063.97968010161, 4069.6744260459386, 4085.55058943516, 4087.4263408587613, 3152.777292009128, 3334.499825026241, 3472.888675623801, 3523.0487768302414, 3580.15866271426, 4467.341931550722, 4919.655624106314, 5085.440601533828, 5098.903735696843, 5145.614078944094, 3973.98013009936, 4256.59562341577, 4567.383403240553, 4597.0, 4605.516420775837, 5582.748776305036, 5602.60781745278, 5610.298712660918, 5612.242347283105, 5635.126555383922, 3822.10180607557, 3838.193979264358, 3841.4237864320576, 3842.4236364545263, 3852.614738526153, 4871.732054736988, 5100.903305789236, 5606.775728970836, 5817.854553636151, 5839.416058394211, 3274.41321356126, 3536.381133301662, 3878.631530004645, 3892.5718171001167, 3915.4909861717792, 3947.9013024674614, 3973.8211780469946, 3978.781167035841, 3987.980060099739, 3988.700847436454, 4424.3142312941545, 4550.2492088804975, 4600.2869555218995, 4625.519833653266, 4639.420072490939, 5626.887462250732, 5627.43725627434, 5643.379228284885, 5661.773529058792, 5670.8810154414905, 1117.714628177586, 1150.672058463334, 1200.2918278215895, 1338.7791014482696, 1360.3538319298452, 843.8734189871568, 853.4580541356283, 858.2705847716855, 865.8657908024267, 872.9607167677469, 4837.806487740451, 5278.023565640292, 5295.841124766186, 5356.812511562077, 5383.842473868137, 5157.742112894341, 5613.578981576398, 5818.970905145447, 5866.240127961594, 5902.2032025676845, 4446.132624297803, 4466.798994045275, 4907.411110666742, 5287.20691896211, 5309.601779866525, 2457.668214791016, 3002.969970300269, 3017.6571425715347, 3040.5439184122115, 3062.846857657108, 5006.898482333881, 5157.484251574888, 5613.410591887875, 5634.211210430543, 5924.348321684612, 4913.926291105637, 5509.696966666872, 5813.360530341659, 5832.737526811219, 5846.269216347957, 5595.580331475075, 5837.5038121758425, 5842.766289348463, 5865.35481097079, 5927.288725352985, 4567.680262381601, 5547.722613869371, 5665.603407761582, 5775.393583673822, 5840.970795145997, 5323.893522129613, 5757.740901659352, 5763.337216220189, 5775.624584402, 5872.853178670567, 5623.971880140737, 5726.398728133486, 5998.710277290404, 6036.879262414815, 6040.486558642565, 3285.342931413679, 3861.517310336208, 3870.767753934773, 3905.882823515299, 3914.0801911551334, 5140.504456969296, 5564.887022595578, 5807.912881306699, 5828.329742079715, 5894.852628684317, 5309.867253318544, 5683.943160568507, 5736.827895163152, 5756.30924289088, 5761.711914404347, 4738.744232778386, 4779.713217206979, 5647.09174774983, 5668.886622267449, 5715.342735585461, 4152.314868046738, 5495.5878309127775, 5560.0, 5585.804496842754, 5586.385497595343, 5202.216814004641, 5396.055690254111, 5690.829275121753, 5711.685857277724, 5739.368669446274, 5279.920801188062, 5520.641158324696, 5576.358718747396, 5602.562885144812, 5655.6656544668585], "value": 4090.9005359889743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.4575676728919, 718.3570704219723, 719.6941299947524, 773.8568364852501, 795.6658203554507, 14941.925290373547, 16291.837081629195, 16321.673566528661, 16344.75482867758, 16345.918270408662, 14779.482718104868, 14804.925975370135, 14863.405463781462, 14895.329710163041, 14909.701805963874, 650.5283669339726, 671.8152508060298, 674.1775034457978, 825.2572684583863, 848.9278411335044, 820.0897004325194, 831.1231650608605, 831.3307787231277, 831.71721614651, 833.8499070167368, 882.2236431939916, 884.0761404332455, 884.4428010353469, 884.4781578868466, 884.7920738626418, 689.9448044156455, 711.590835269722, 866.5580553917484, 878.8110556230409, 879.0769691823559, 653.9673016349163, 664.9567778094457, 665.6904539389208, 666.7899611622372, 667.8397184675691, 15249.161296128708, 15325.540233793005, 15331.0, 15333.156676382794, 15339.156346400943, 13660.453581856715, 13817.0, 13899.583012509642, 13928.651783705387, 14067.36696848634, 11873.465694043789, 12424.316662583555, 12478.625641230778, 12711.55509557161, 12940.288284144368, 4550.38569793077, 4595.540445955411, 4716.669833111683, 4739.170645137087, 4770.546798054179, 110809.0, 115458.42270788677, 116021.25968110401, 118796.0, 118842.40578797137, 9723.416595004323, 10140.543675534618, 10267.383956962607, 11131.666050018512, 11149.72125696864, 19901.900490497745, 19908.0, 19931.302404415776, 19962.401127966183, 19972.50068748293, 7311.561306321638, 7413.925860741324, 7558.962205188939, 7749.496282741604, 8108.675652973815, 4282.057947251599, 4289.613934745826, 4362.498312694017, 4466.932996005063, 4524.796384162721, 2766.681831589353, 3464.72282217422, 3529.9294014119573, 3598.784072955631, 3762.172322089136, 624.3101372982788, 636.0935666674969, 636.4081404293959, 651.4365074210868, 658.6937074260492, 587.5769445998874, 615.6521565315583, 622.4024936061342, 622.9688515574203, 626.370497649859, 8772.385932984758, 8905.332100092519, 8928.419652722552, 9134.451932884049, 9178.036306187754, 588.7644942023139, 610.3896103896104, 616.309733098932, 628.3716283716284, 653.4837478392017, 4394.428724265825, 4418.3151611499625, 4455.933161002587, 4456.551620723213, 4542.182407166676, 151784.0, 157146.21426892793, 158563.0, 158912.0, 161111.0, 119319.0, 129469.0, 130587.24966089531, 130936.0, 133123.0, 110560.89439105667, 113998.52856375978, 114633.4268328653, 116764.0, 119730.0, 7962.203779621991, 8123.79690507742, 8221.890044843869, 8510.914890851012, 8538.743837684879, 46828.7658561705, 60615.39384606097, 61568.46078848065, 62053.0, 62583.0, 60536.09195862154, 73829.0, 90259.54870225607, 93415.13169736703, 94149.0, 10962.451877406258, 11077.83383249268, 11215.88784112181, 11260.662180134608, 11374.488148033524, 12129.818052729393, 12226.572069977863, 12411.875881241072, 12484.188527745668, 13086.869131308566, 12093.818592721293, 12310.630681079223, 12585.0, 12611.991040716537, 12643.431045603154, 10103.848442273225, 12240.0, 12265.38673066361, 12638.936805315914, 12653.557125500563, 11919.940400297943, 12006.159568830099, 13112.672183195114, 13517.0, 14064.929675351967, 11287.887121128684, 11570.884291157317, 11614.88385116138, 11794.29234245948, 12102.939485302517, 11437.942810285895, 11490.425478725863, 11574.421278936188, 11707.356095414834, 11799.76400472003], "value": 7629.626659358884, "unit": "score"}], "name": "dromaeo_css", "value": 7253.853595021956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 115.0, 167.0, 166.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 105.0, 96.0, 165.0, 96.0, 129.0, 138.0, 139.0, 167.0, 109.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 183.0, 185.0, 181.0, 183.0, 183.0, 184.0, 182.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 88.0, 62.0, 69.0, 60.0, 59.0, 82.0, 58.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 94.0, 70.0, 68.0, 70.0, 90.0, 67.0, 68.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 125.0, 87.0, 84.0, 88.0, 84.0, 96.0, 128.0, 116.0, 83.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 103.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 100.0, 139.0, 135.0, 84.0, 86.0, 84.0, 87.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 53.0, 52.0, 54.0, 57.0, 57.0, 56.0, 55.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 75.0, 99.0, 103.0, 98.0, 81.0, 70.0, 70.0, 71.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 86.0, 85.0, 83.0, 86.0, 82.0, 83.0, 89.0, 108.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 136.0, 152.0, 146.0, 162.0, 151.0, 151.0, 171.0, 129.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 163.0, 160.0, 168.0, 219.0, 172.0, 163.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 64.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1478.3000000000002, "alertThreshold": 2.0}]} 14:24:42 INFO - Return code: 0 14:24:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:24:42 INFO - # TBPL SUCCESS # 14:24:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:24:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:24:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:24:42 INFO - 2016-10-04 14:24:42.955 screenresolution[1670:9935] starting screenresolution argv=screenresolution get 14:24:42 INFO - 2016-10-04 14:24:42.958 screenresolution[1670:9935] Display 0: 1600x1200x32@60 14:24:42 INFO - 2016-10-04 14:24:42.964 screenresolution[1671:9938] starting screenresolution argv=screenresolution list 14:24:42 INFO - Available Modes on Display 0 14:24:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:24:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:24:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:24:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:24:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:24:43 INFO - Intel Iris: 14:24:43 INFO - Chipset Model: Intel Iris 14:24:43 INFO - Type: GPU 14:24:43 INFO - Bus: Built-In 14:24:43 INFO - VRAM (Dynamic, Max): 1536 MB 14:24:43 INFO - Vendor: Intel (0x8086) 14:24:43 INFO - Device ID: 0x0a2e 14:24:43 INFO - Revision ID: 0x0009 14:24:43 INFO - Displays: 14:24:43 INFO - Display: 14:24:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:24:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:24:43 INFO - Display Serial Number: 1600x1200 60 14:24:43 INFO - Main Display: Yes 14:24:43 INFO - Mirror: Off 14:24:43 INFO - Online: Yes 14:24:43 INFO - Rotation: Supported 14:24:43 INFO - Return code: 0 14:24:43 INFO - Running post-action listener: _resource_record_post_action 14:24:43 INFO - [mozharness: 2016-10-04 21:24:43.200281Z] Finished run-tests step (success) 14:24:43 INFO - Running post-run listener: _resource_record_post_run 14:24:43 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 38339584; Write bytes: 661001216; Read time: 375; Write time: 2160 14:24:43 INFO - TinderboxPrint: CPU usage
53.2% 14:24:43 INFO - TinderboxPrint: I/O read bytes / time
38,339,584 / 375 14:24:43 INFO - TinderboxPrint: I/O write bytes / time
661,001,216 / 2,160 14:24:43 INFO - TinderboxPrint: CPU idle
2,268.2 (46.8%) 14:24:43 INFO - TinderboxPrint: CPU system
962.9 (19.9%) 14:24:43 INFO - TinderboxPrint: CPU user
1,610.6 (33.3%) 14:24:43 INFO - TinderboxPrint: Swap in / out
401,022,976 / 0 14:24:43 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 361284096; Write bytes: 355956736; Read time: 27414; Write time: 645 14:24:43 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32136192; Write bytes: 294861824; Read time: 294; Write time: 1480 14:24:43 INFO - Running post-run listener: _upload_blobber_files 14:24:43 INFO - Blob upload gear active. 14:24:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:24:43 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 14:24:43 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'] 14:24:43 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 14:24:44 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:24:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:45 INFO - (blobuploader) - INFO - Done attempting. 14:24:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:24:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:24:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:46 INFO - (blobuploader) - INFO - Done attempting. 14:24:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:24:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:48 INFO - (blobuploader) - INFO - Done attempting. 14:24:48 INFO - (blobuploader) - INFO - Iteration through files over. 14:24:48 INFO - Return code: 0 14:24:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:24:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:24:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb91ffe8bc5b6d438f4051641d56ca0db36eb65199319303aca56ef512623e37ec95289ae4d4bcaf5ae3f7def5397320c5dc255b044b08d2bf7ee672d7bf3484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dda12785e868f2433e70ae31b67b6ec005b9e3b61bf74dd3bbfa2581cd38be37769ac1b274583e52e589178bdfaaf76ef0794a2cf96846cbd99d9f359fc53445", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0774e4c0bff77189a0e527e71283ada81b4676e255056f55c1ee3565563111b38003b2a40d6c8c044471a7784e94eaa77243b857bcb49552f4fdc8e351bf9c10"} 14:24:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:24:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:24:48 INFO - Contents: 14:24:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb91ffe8bc5b6d438f4051641d56ca0db36eb65199319303aca56ef512623e37ec95289ae4d4bcaf5ae3f7def5397320c5dc255b044b08d2bf7ee672d7bf3484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dda12785e868f2433e70ae31b67b6ec005b9e3b61bf74dd3bbfa2581cd38be37769ac1b274583e52e589178bdfaaf76ef0794a2cf96846cbd99d9f359fc53445", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0774e4c0bff77189a0e527e71283ada81b4676e255056f55c1ee3565563111b38003b2a40d6c8c044471a7784e94eaa77243b857bcb49552f4fdc8e351bf9c10"} 14:24:48 INFO - Running post-run listener: copy_logs_to_upload_dir 14:24:48 INFO - Copying logs to upload dir... 14:24:48 INFO - mkdir: /builds/slave/test/build/upload/logs 14:24:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.641974 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-04 14:24:48.944084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 14:24:48.947277) ========= 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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb91ffe8bc5b6d438f4051641d56ca0db36eb65199319303aca56ef512623e37ec95289ae4d4bcaf5ae3f7def5397320c5dc255b044b08d2bf7ee672d7bf3484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dda12785e868f2433e70ae31b67b6ec005b9e3b61bf74dd3bbfa2581cd38be37769ac1b274583e52e589178bdfaaf76ef0794a2cf96846cbd99d9f359fc53445", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0774e4c0bff77189a0e527e71283ada81b4676e255056f55c1ee3565563111b38003b2a40d6c8c044471a7784e94eaa77243b857bcb49552f4fdc8e351bf9c10"} build_url:https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/arg9JY88TCGjy-fFn3kyfA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb91ffe8bc5b6d438f4051641d56ca0db36eb65199319303aca56ef512623e37ec95289ae4d4bcaf5ae3f7def5397320c5dc255b044b08d2bf7ee672d7bf3484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dda12785e868f2433e70ae31b67b6ec005b9e3b61bf74dd3bbfa2581cd38be37769ac1b274583e52e589178bdfaaf76ef0794a2cf96846cbd99d9f359fc53445", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0774e4c0bff77189a0e527e71283ada81b4676e255056f55c1ee3565563111b38003b2a40d6c8c044471a7784e94eaa77243b857bcb49552f4fdc8e351bf9c10"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 14:24:48.980501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:24:48.980876) ========= 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.dfGbK8vMa3/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.AtVzaLNpAi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005174 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:24:49.029911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 14:24:49.030237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 14:24:49.030571) ========= ========= Total master_lag: 0.17 =========