builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0209 starttime: 1476358044.73 results: success (0) buildid: 20161013014024 builduid: f2a3128fdb0a487db1ec0acfb2acde6a revision: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.735150) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.735641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.735945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.762886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.763250) ========= 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.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-13 04:27:24-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2016-10-13 04:27:24 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.907835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.908136) ========= 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.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.020648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:24.959880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:27:24.963242) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd067bd545083034fe8c1a9c5f1c39cf4fd257ea --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 cd067bd545083034fe8c1a9c5f1c39cf4fd257ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-13 04:27:25,043 truncating revision to first 12 chars 2016-10-13 04:27:25,043 Setting DEBUG logging. 2016-10-13 04:27:25,043 attempt 1/10 2016-10-13 04:27:25,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd067bd54508?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 04:27:26,103 unpacking tar archive at: mozilla-aurora-cd067bd54508/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:27:26.322996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.323336) ========= script_repo_revision: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.323708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.324002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.341842) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-13 04:27:26.342144) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:27:26 INFO - MultiFileLogger online at 20161013 04:27:26 in /builds/slave/test 04:27:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:26 INFO - {'append_to_log': False, 04:27:26 INFO - 'base_work_dir': '/builds/slave/test', 04:27:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:26 INFO - 'branch': 'Mozilla-Aurora', 04:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:26 INFO - 'config_files': ('talos/mac_config.py',), 04:27:26 INFO - 'default_actions': ('clobber', 04:27:26 INFO - 'read-buildbot-config', 04:27:26 INFO - 'download-and-extract', 04:27:26 INFO - 'populate-webroot', 04:27:26 INFO - 'create-virtualenv', 04:27:26 INFO - 'install', 04:27:26 INFO - 'run-tests'), 04:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:26 INFO - 'download_minidump_stackwalk': True, 04:27:26 INFO - 'download_symbols': 'ondemand', 04:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:26 INFO - 'installer_path': 'installer.exe', 04:27:26 INFO - 'log_level': 'info', 04:27:26 INFO - 'log_name': 'talos', 04:27:26 INFO - 'log_to_console': True, 04:27:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:27:26 INFO - 'opt_config_files': (), 04:27:26 INFO - 'pip_index': False, 04:27:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:26 INFO - 'cmd': ('bash', 04:27:26 INFO - '-c', 04:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:26 INFO - 'enabled': True, 04:27:26 INFO - 'halt_on_failure': False, 04:27:26 INFO - 'name': 'check_screen_resolution'},), 04:27:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:26 INFO - 'cmd': ('bash', 04:27:26 INFO - '-c', 04:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:26 INFO - 'enabled': True, 04:27:26 INFO - 'halt_on_failure': False, 04:27:26 INFO - 'name': 'check_screen_resolution'},), 04:27:26 INFO - 'run_cmd_checks_enabled': True, 04:27:26 INFO - 'sps_profile': False, 04:27:26 INFO - 'sps_profile_interval': 0, 04:27:26 INFO - 'suite': 'dromaeojs-e10s', 04:27:26 INFO - 'system_bits': '32', 04:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:26 INFO - 'title': 't-yosemite-r7-0209', 04:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:26 INFO - 'use_talos_json': True, 04:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:26 INFO - 'work_dir': 'build'} 04:27:26 INFO - [mozharness: 2016-10-13 11:27:26.531921Z] Running clobber step. 04:27:26 INFO - Running pre-action listener: _resource_record_pre_action 04:27:26 INFO - Running main action method: clobber 04:27:26 INFO - rmtree: /builds/slave/test/build 04:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:28 INFO - Running post-action listener: _resource_record_post_action 04:27:28 INFO - [mozharness: 2016-10-13 11:27:28.025497Z] Finished clobber step (success) 04:27:28 INFO - [mozharness: 2016-10-13 11:27:28.025617Z] Running read-buildbot-config step. 04:27:28 INFO - Running pre-action listener: _resource_record_pre_action 04:27:28 INFO - Running main action method: read_buildbot_config 04:27:28 INFO - Using buildbot properties: 04:27:28 INFO - { 04:27:28 INFO - "project": "", 04:27:28 INFO - "product": "firefox", 04:27:28 INFO - "script_repo_revision": "production", 04:27:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 04:27:28 INFO - "repository": "", 04:27:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 04:27:28 INFO - "buildid": "20161013014024", 04:27:28 INFO - "pgo_build": "False", 04:27:28 INFO - "basedir": "/builds/slave/test", 04:27:28 INFO - "buildnumber": 1, 04:27:28 INFO - "slavename": "t-yosemite-r7-0209", 04:27:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:27:28 INFO - "platform": "yosemite_r7", 04:27:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:27:28 INFO - "branch": "mozilla-aurora", 04:27:28 INFO - "repo_path": "releases/mozilla-aurora", 04:27:28 INFO - "revision": "cd067bd545083034fe8c1a9c5f1c39cf4fd257ea", 04:27:28 INFO - "stage_platform": "macosx64", 04:27:28 INFO - "builduid": "f2a3128fdb0a487db1ec0acfb2acde6a", 04:27:28 INFO - "slavebuilddir": "test" 04:27:28 INFO - } 04:27:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 04:27:28 INFO - Running post-action listener: _resource_record_post_action 04:27:28 INFO - [mozharness: 2016-10-13 11:27:28.028947Z] Finished read-buildbot-config step (success) 04:27:28 INFO - [mozharness: 2016-10-13 11:27:28.029084Z] Running download-and-extract step. 04:27:28 INFO - Running pre-action listener: _resource_record_pre_action 04:27:28 INFO - Running main action method: download_and_extract 04:27:28 INFO - mkdir: /builds/slave/test/build/tests 04:27:28 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')]} 04:27:28 INFO - trying https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 04:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:28 INFO - Downloaded 1199 bytes. 04:27:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 04:27:28 INFO - Using the following test package requirements: 04:27:28 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:27:28 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 04:27:28 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 04:27:28 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'jsshell-mac.zip'], 04:27:28 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 04:27:28 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:27:28 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 04:27:28 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 04:27:28 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 04:27:28 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:28 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 04:27:28 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:27:29 INFO - Expected file size: 16435313 04:27:36 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 04:27:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:27:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:27:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:27:36 INFO - Expected file size: 16435313 04:27:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 04:27:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:27:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 04:27:44 INFO - Expected file size: 14414059 04:27:46 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')]} 04:27:46 INFO - trying https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 04:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:49 INFO - Downloaded 115363558 bytes. 04:27:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:49 INFO - mkdir: /builds/slave/test/properties 04:27:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:49 INFO - Contents: 04:27:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:50 INFO - Running post-action listener: _resource_record_post_action 04:27:50 INFO - Running post-action listener: set_extra_try_arguments 04:27:50 INFO - [mozharness: 2016-10-13 11:27:50.456055Z] Finished download-and-extract step (success) 04:27:50 INFO - [mozharness: 2016-10-13 11:27:50.456171Z] Running populate-webroot step. 04:27:50 INFO - Running pre-action listener: _resource_record_pre_action 04:27:50 INFO - Running main action method: populate_webroot 04:27:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:50 INFO - '--tppagecycles', 04:27:50 INFO - '7'], 04:27:50 INFO - 'tests': ['tsvgm']}}, 04:27:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['damp', 'tps']}, 04:27:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'tests': ['damp', 'tps']}, 04:27:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['dromaeo_dom']}, 04:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['basic_compositor_video']}, 04:27:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['tsvgx', 04:27:50 INFO - 'tsvgr_opacity', 04:27:50 INFO - 'tart', 04:27:50 INFO - 'tscrollx', 04:27:50 INFO - 'cart']}, 04:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:50 INFO - 'tsvgr_opacity', 04:27:50 INFO - 'tart', 04:27:50 INFO - 'tscrollx', 04:27:50 INFO - 'cart']}, 04:27:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-e10s'], 04:27:50 INFO - 'tests': ['tp5o']}, 04:27:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'tests': ['tp5o']}, 04:27:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-e10s', 04:27:50 INFO - '--xperf_path', 04:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:50 INFO - 'tests': ['tp5n']}, 04:27:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:50 INFO - 'talos_options': ['--xperf_path', 04:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:50 INFO - 'tests': ['tp5n']}}, 04:27:50 INFO - 'talos.zip': {'path': '', 04:27:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:50 INFO - Running post-action listener: _resource_record_post_action 04:27:50 INFO - [mozharness: 2016-10-13 11:27:50.474716Z] Finished populate-webroot step (success) 04:27:50 INFO - [mozharness: 2016-10-13 11:27:50.474851Z] Running create-virtualenv step. 04:27:50 INFO - Running pre-action listener: _resource_record_pre_action 04:27:50 INFO - Running main action method: create_virtualenv 04:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:50 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 04:27:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:50 INFO - Using real prefix '/tools/python27' 04:27:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:54 INFO - Installing pip.................done. 04:27:54 INFO - Return code: 0 04:27:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:54 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')]} 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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')]} 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:27:54 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 04:27:54 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 04:27:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:27:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:54 INFO - 'HOME': '/Users/cltbld', 04:27:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:54 INFO - 'LOGNAME': 'cltbld', 04:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:54 INFO - 'MOZ_NO_REMOTE': '1', 04:27:54 INFO - 'NO_EM_RESTART': '1', 04:27:54 INFO - 'PAGER': '/bin/cat', 04:27:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:54 INFO - 'PWD': '/builds/slave/test', 04:27:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:54 INFO - 'SHELL': '/bin/bash', 04:27:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:27:54 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:27:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:54 INFO - 'USER': 'cltbld', 04:27:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:54 INFO - 'XPC_FLAGS': '0x0', 04:27:54 INFO - 'XPC_SERVICE_NAME': '0', 04:27:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:54 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 04:27:54 INFO - Cleaning up... 04:27:54 INFO - Return code: 0 04:27:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:54 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')]} 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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')]} 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:27:54 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 04:27:54 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 04:27:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:27:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:54 INFO - 'HOME': '/Users/cltbld', 04:27:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:54 INFO - 'LOGNAME': 'cltbld', 04:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:54 INFO - 'MOZ_NO_REMOTE': '1', 04:27:54 INFO - 'NO_EM_RESTART': '1', 04:27:54 INFO - 'PAGER': '/bin/cat', 04:27:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:54 INFO - 'PWD': '/builds/slave/test', 04:27:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:54 INFO - 'SHELL': '/bin/bash', 04:27:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:27:54 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:27:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:54 INFO - 'USER': 'cltbld', 04:27:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:54 INFO - 'XPC_FLAGS': '0x0', 04:27:54 INFO - 'XPC_SERVICE_NAME': '0', 04:27:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:54 INFO - Downloading/unpacking psutil>=3.1.1 04:27:54 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 04:27:54 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 04:27:54 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 04:27:54 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 04:27:54 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 04:27:54 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 04:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:57 INFO - Installing collected packages: psutil 04:27:57 INFO - Running setup.py install for psutil 04:27:57 INFO - building 'psutil._psutil_osx' extension 04:27:57 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 04:27:58 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 04:27:58 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 04:27:58 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 04:27:58 INFO - building 'psutil._psutil_posix' extension 04:27:58 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 04:27:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:27:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:27:58 INFO - ^ 04:27:58 INFO - 1 warning generated. 04:27:58 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 04:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:58 INFO - Successfully installed psutil 04:27:58 INFO - Cleaning up... 04:27:58 INFO - Return code: 0 04:27:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:58 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:27:58 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 04:27:58 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 04:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:58 INFO - 'HOME': '/Users/cltbld', 04:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:58 INFO - 'LOGNAME': 'cltbld', 04:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:58 INFO - 'MOZ_NO_REMOTE': '1', 04:27:58 INFO - 'NO_EM_RESTART': '1', 04:27:58 INFO - 'PAGER': '/bin/cat', 04:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:58 INFO - 'PWD': '/builds/slave/test', 04:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:58 INFO - 'SHELL': '/bin/bash', 04:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:27:58 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:58 INFO - 'USER': 'cltbld', 04:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:58 INFO - 'XPC_FLAGS': '0x0', 04:27:58 INFO - 'XPC_SERVICE_NAME': '0', 04:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:28:01 INFO - Installing collected packages: mozsystemmonitor 04:28:01 INFO - Running setup.py install for mozsystemmonitor 04:28:01 INFO - Successfully installed mozsystemmonitor 04:28:01 INFO - Cleaning up... 04:28:01 INFO - Return code: 0 04:28:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:28:01 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')]} 04:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:01 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')]} 04:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:01 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28:01 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 04:28:01 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 04:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:01 INFO - 'HOME': '/Users/cltbld', 04:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:01 INFO - 'LOGNAME': 'cltbld', 04:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:01 INFO - 'MOZ_NO_REMOTE': '1', 04:28:01 INFO - 'NO_EM_RESTART': '1', 04:28:01 INFO - 'PAGER': '/bin/cat', 04:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:01 INFO - 'PWD': '/builds/slave/test', 04:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:01 INFO - 'SHELL': '/bin/bash', 04:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:01 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:01 INFO - 'USER': 'cltbld', 04:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:01 INFO - 'XPC_FLAGS': '0x0', 04:28:01 INFO - 'XPC_SERVICE_NAME': '0', 04:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:28:02 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 04:28:02 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 04:28:02 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 04:28:02 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 04:28:02 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 04:28:02 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 04:28:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:28:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:28:04 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 04:28:04 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 04:28:04 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 04:28:04 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 04:28:04 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 04:28:04 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 04:28:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:28:04 INFO - warning: no files found matching '*.txt' 04:28:04 INFO - no previously-included directories found matching 'build' 04:28:04 INFO - no previously-included directories found matching 'dist' 04:28:04 INFO - no previously-included directories found matching '.git*' 04:28:04 INFO - Installing collected packages: jsonschema, functools32 04:28:05 INFO - Running setup.py install for functools32 04:28:05 INFO - warning: no files found matching '*.txt' 04:28:05 INFO - no previously-included directories found matching 'build' 04:28:05 INFO - no previously-included directories found matching 'dist' 04:28:05 INFO - no previously-included directories found matching '.git*' 04:28:05 INFO - Successfully installed jsonschema functools32 04:28:05 INFO - Cleaning up... 04:28:05 INFO - Return code: 0 04:28:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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', '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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:28: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 functools32==3.2.3-2 04:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:05 INFO - 'HOME': '/Users/cltbld', 04:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:05 INFO - 'LOGNAME': 'cltbld', 04:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:05 INFO - 'MOZ_NO_REMOTE': '1', 04:28:05 INFO - 'NO_EM_RESTART': '1', 04:28:05 INFO - 'PAGER': '/bin/cat', 04:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:05 INFO - 'PWD': '/builds/slave/test', 04:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:05 INFO - 'SHELL': '/bin/bash', 04:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:05 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:05 INFO - 'USER': 'cltbld', 04:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:05 INFO - 'XPC_FLAGS': '0x0', 04:28:05 INFO - 'XPC_SERVICE_NAME': '0', 04:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:28:05 INFO - Cleaning up... 04:28:05 INFO - Return code: 0 04:28:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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', '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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:28: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 blobuploader==1.2.4 04:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:05 INFO - 'HOME': '/Users/cltbld', 04:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:05 INFO - 'LOGNAME': 'cltbld', 04:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:05 INFO - 'MOZ_NO_REMOTE': '1', 04:28:05 INFO - 'NO_EM_RESTART': '1', 04:28:05 INFO - 'PAGER': '/bin/cat', 04:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:05 INFO - 'PWD': '/builds/slave/test', 04:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:05 INFO - 'SHELL': '/bin/bash', 04:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:05 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:05 INFO - 'USER': 'cltbld', 04:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:05 INFO - 'XPC_FLAGS': '0x0', 04:28:05 INFO - 'XPC_SERVICE_NAME': '0', 04:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:28:05 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 04:28:05 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 04:28:05 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 04:28:05 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 04:28:05 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 04:28:05 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 04:28:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:28:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:28:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:08 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 04:28:09 INFO - Downloading docopt-0.6.1.tar.gz 04:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:09 INFO - Running setup.py install for blobuploader 04:28:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:28:09 INFO - Running setup.py install for requests 04:28:10 INFO - Running setup.py install for docopt 04:28:10 INFO - Successfully installed blobuploader requests docopt 04:28:10 INFO - Cleaning up... 04:28:10 INFO - Return code: 0 04:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:10 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')]} 04:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:10 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')]} 04:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:10 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28:10 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 04:28:10 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 04:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:10 INFO - 'HOME': '/Users/cltbld', 04:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:10 INFO - 'LOGNAME': 'cltbld', 04:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:10 INFO - 'MOZ_NO_REMOTE': '1', 04:28:10 INFO - 'NO_EM_RESTART': '1', 04:28:10 INFO - 'PAGER': '/bin/cat', 04:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:10 INFO - 'PWD': '/builds/slave/test', 04:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:10 INFO - 'SHELL': '/bin/bash', 04:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:10 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:10 INFO - 'USER': 'cltbld', 04:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:10 INFO - 'XPC_FLAGS': '0x0', 04:28:10 INFO - 'XPC_SERVICE_NAME': '0', 04:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:10 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-d8_r5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:10 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BQu3Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:10 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-kGQ00W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:10 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-4ycrhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-DIRwMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ZB4iiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-vEFIdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KMUTY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-jfGbyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hgLvQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-jgN40N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-MA9FAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:11 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-xmCrHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WyASOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-yEoB8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-pV3uMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:12 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-S_ogLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:12 INFO - Running setup.py install for manifestparser 04:28:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:28:12 INFO - Running setup.py install for mozcrash 04:28:12 INFO - Running setup.py install for mozdebug 04:28:12 INFO - Running setup.py install for mozdevice 04:28:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:28:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Running setup.py install for mozfile 04:28:13 INFO - Running setup.py install for mozhttpd 04:28:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Running setup.py install for mozinfo 04:28:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Running setup.py install for mozInstall 04:28:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Running setup.py install for mozleak 04:28:13 INFO - Running setup.py install for mozlog 04:28:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:28:13 INFO - Running setup.py install for moznetwork 04:28:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Running setup.py install for mozprocess 04:28:14 INFO - Running setup.py install for mozprofile 04:28:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Running setup.py install for mozrunner 04:28:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Running setup.py install for mozscreenshot 04:28:14 INFO - Running setup.py install for moztest 04:28:14 INFO - Running setup.py install for mozversion 04:28:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:14 INFO - Cleaning up... 04:28:14 INFO - Return code: 0 04:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:14 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')]} 04:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:14 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')]} 04:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:14 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28:14 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 04:28:14 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 04:28:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:14 INFO - 'HOME': '/Users/cltbld', 04:28:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:14 INFO - 'LOGNAME': 'cltbld', 04:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:14 INFO - 'MOZ_NO_REMOTE': '1', 04:28:14 INFO - 'NO_EM_RESTART': '1', 04:28:14 INFO - 'PAGER': '/bin/cat', 04:28:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:14 INFO - 'PWD': '/builds/slave/test', 04:28:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:14 INFO - 'SHELL': '/bin/bash', 04:28:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:14 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:14 INFO - 'USER': 'cltbld', 04:28:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:14 INFO - 'XPC_FLAGS': '0x0', 04:28:14 INFO - 'XPC_SERVICE_NAME': '0', 04:28:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-UQDG4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-f5jEcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-5qt5KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-tQDp5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-wJjss4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-axJb_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-i6TNn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:15 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)) 04:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:15 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-wvCbgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-j2VgLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-W3owOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-usULC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-isoyzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WE4MGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-AI8sJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-W7YoYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-6nO8s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:16 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)) 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:16 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ROyTH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:17 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)) 04:28:17 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)) 04:28:17 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)) 04:28:17 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)) 04:28:17 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)) 04:28:17 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)) 04:28:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:17 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 04:28:17 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 04:28:17 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 04:28:17 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 04:28:17 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 04:28:17 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 04:28:19 INFO - Downloading blessings-1.6.tar.gz 04:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:19 INFO - Installing collected packages: blessings 04:28:19 INFO - Running setup.py install for blessings 04:28:19 INFO - Successfully installed blessings 04:28:19 INFO - Cleaning up... 04:28:19 INFO - Return code: 0 04:28:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:20 INFO - Reading from file tmpfile_stdout 04:28:20 INFO - Current package versions: 04:28:20 INFO - blessings == 1.6 04:28:20 INFO - blobuploader == 1.2.4 04:28:20 INFO - docopt == 0.6.1 04:28:20 INFO - functools32 == 3.2.3-2 04:28:20 INFO - jsonschema == 2.5.1 04:28:20 INFO - manifestparser == 1.1 04:28:20 INFO - mozInstall == 1.12 04:28:20 INFO - mozcrash == 0.17 04:28:20 INFO - mozdebug == 0.1 04:28:20 INFO - mozdevice == 0.48 04:28:20 INFO - mozfile == 1.2 04:28:20 INFO - mozhttpd == 0.7 04:28:20 INFO - mozinfo == 0.9 04:28:20 INFO - mozleak == 0.1 04:28:20 INFO - mozlog == 3.4 04:28:20 INFO - moznetwork == 0.27 04:28:20 INFO - mozprocess == 0.23 04:28:20 INFO - mozprofile == 0.28 04:28:20 INFO - mozrunner == 6.12 04:28:20 INFO - mozscreenshot == 0.1 04:28:20 INFO - mozsystemmonitor == 0.3 04:28:20 INFO - moztest == 0.7 04:28:20 INFO - mozversion == 1.4 04:28:20 INFO - psutil == 3.1.1 04:28:20 INFO - requests == 1.2.3 04:28:20 INFO - wsgiref == 0.1.2 04:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:20 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')]} 04:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:20 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')]} 04:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:20 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28:20 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 04:28:20 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 04:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:20 INFO - 'HOME': '/Users/cltbld', 04:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:20 INFO - 'LOGNAME': 'cltbld', 04:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:20 INFO - 'MOZ_NO_REMOTE': '1', 04:28:20 INFO - 'NO_EM_RESTART': '1', 04:28:20 INFO - 'PAGER': '/bin/cat', 04:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:20 INFO - 'PWD': '/builds/slave/test', 04:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:20 INFO - 'SHELL': '/bin/bash', 04:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:20 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:20 INFO - 'USER': 'cltbld', 04:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:20 INFO - 'XPC_FLAGS': '0x0', 04:28:20 INFO - 'XPC_SERVICE_NAME': '0', 04:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 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)) 04:28:20 INFO - Cleaning up... 04:28:20 INFO - Return code: 0 04:28:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:28:20 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')]} 04:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:20 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')]} 04:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:20 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 0x107806490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10777c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1f15a60f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, '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.YRgEzUAPBH/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.drYIB25IXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 04:28:20 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 04:28:20 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 04:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:20 INFO - 'HOME': '/Users/cltbld', 04:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:20 INFO - 'LOGNAME': 'cltbld', 04:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:20 INFO - 'MOZ_NO_REMOTE': '1', 04:28:20 INFO - 'NO_EM_RESTART': '1', 04:28:20 INFO - 'PAGER': '/bin/cat', 04:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:20 INFO - 'PWD': '/builds/slave/test', 04:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:20 INFO - 'SHELL': '/bin/bash', 04:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:20 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:20 INFO - 'USER': 'cltbld', 04:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:20 INFO - 'XPC_FLAGS': '0x0', 04:28:20 INFO - 'XPC_SERVICE_NAME': '0', 04:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:28:20 INFO - Cleaning up... 04:28:20 INFO - Return code: 0 04:28:20 INFO - Running post-action listener: _resource_record_post_action 04:28:20 INFO - Running post-action listener: _start_resource_monitoring 04:28:20 INFO - Starting resource monitoring. 04:28:20 INFO - [mozharness: 2016-10-13 11:28:20.698854Z] Finished create-virtualenv step (success) 04:28:20 INFO - [mozharness: 2016-10-13 11:28:20.699836Z] Running install step. 04:28:20 INFO - Running pre-action listener: _resource_record_pre_action 04:28:20 INFO - Running main action method: install 04:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:20 INFO - Reading from file tmpfile_stdout 04:28:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:28:21 INFO - Reading from file tmpfile_stdout 04:28:21 INFO - Output received: 04:28:21 INFO - Usage: mozinstall [options] installer 04:28:21 INFO - Options: 04:28:21 INFO - -h, --help show this help message and exit 04:28:21 INFO - -d DEST, --destination=DEST 04:28:21 INFO - Directory to install application into. [default: 04:28:21 INFO - "/builds/slave/test"] 04:28:21 INFO - --app=APP Application being installed. [default: firefox] 04:28:21 INFO - mkdir: /builds/slave/test/build/application 04:28:21 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'] 04:28:21 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 04:28:53 INFO - Reading from file tmpfile_stdout 04:28:53 INFO - Output received: 04:28:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:28:53 INFO - Running post-action listener: _resource_record_post_action 04:28:53 INFO - [mozharness: 2016-10-13 11:28:53.237001Z] Finished install step (success) 04:28:53 INFO - [mozharness: 2016-10-13 11:28:53.237135Z] Running run-tests step. 04:28:53 INFO - Running pre-action listener: _resource_record_pre_action 04:28:53 INFO - Running main action method: run_tests 04:28:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:53 INFO - 2016-10-13 04:28:53.251 screenresolution[1914:16374] starting screenresolution argv=screenresolution get 04:28:53 INFO - 2016-10-13 04:28:53.254 screenresolution[1914:16374] Display 0: 1600x1200x32@60 04:28:53 INFO - 2016-10-13 04:28:53.259 screenresolution[1915:16377] starting screenresolution argv=screenresolution list 04:28:53 INFO - Available Modes on Display 0 04:28:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:53 INFO - Intel Iris: 04:28:53 INFO - Chipset Model: Intel Iris 04:28:53 INFO - Type: GPU 04:28:53 INFO - Bus: Built-In 04:28:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:53 INFO - Vendor: Intel (0x8086) 04:28:53 INFO - Device ID: 0x0a2e 04:28:53 INFO - Revision ID: 0x0009 04:28:53 INFO - Displays: 04:28:53 INFO - Display: 04:28:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:53 INFO - Display Serial Number: 1600x1200 60 04:28:53 INFO - Main Display: Yes 04:28:53 INFO - Mirror: Off 04:28:53 INFO - Online: Yes 04:28:53 INFO - Rotation: Supported 04:28:53 INFO - Return code: 0 04:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:53 INFO - Python 2.7.3 04:28:53 INFO - Return code: 0 04:28:53 INFO - grabbing minidump binary from tooltool 04:28:53 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')]} 04:28:53 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 0x10761ad30>, '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 0x107480db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107612b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:53 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 04:28:53 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 04:28:53 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 04:28:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:53 INFO - Return code: 0 04:28:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgEzUAPBH/Render', 04:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:53 INFO - 'HOME': '/Users/cltbld', 04:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:53 INFO - 'LOGNAME': 'cltbld', 04:28:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:53 INFO - 'MOZ_NO_REMOTE': '1', 04:28:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:53 INFO - 'NO_EM_RESTART': '1', 04:28:53 INFO - 'PAGER': '/bin/cat', 04:28:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:53 INFO - 'PWD': '/builds/slave/test', 04:28:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:53 INFO - 'SHELL': '/bin/bash', 04:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.drYIB25IXn/Listeners', 04:28:53 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 04:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:53 INFO - 'USER': 'cltbld', 04:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:53 INFO - 'XPC_FLAGS': '0x0', 04:28:53 INFO - 'XPC_SERVICE_NAME': '0', 04:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:28:53 INFO - mozversion application_buildid: 20161013014024 04:28:53 INFO - mozversion application_changeset: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea 04:28:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:28:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:53 INFO - mozversion application_name: Firefox 04:28:53 INFO - mozversion application_remotingname: firefox-dev 04:28:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:28:53 INFO - mozversion application_vendor: Mozilla 04:28:53 INFO - mozversion application_version: 51.0a2 04:28:53 INFO - mozversion platform_buildid: 20161013014024 04:28:53 INFO - mozversion platform_changeset: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea 04:28:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:28:53 INFO - mozversion platform_version: 51.0a2 04:28:53 INFO - using testdate: 1476358133 04:28:53 INFO - actual date: 1476358133 04:28:53 INFO - starting webserver on 'localhost:53405' 04:28:53 INFO - SUITE-START | Running 2 tests 04:28:53 INFO - TEST-START | dromaeo_css 04:28:53 INFO - operating with platform_type : mac_ 04:28:53 INFO - Initialising browser for dromaeo_css test... 04:28:53 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpNmTjLL/profile http://localhost:53405/getInfo.html) 04:28:56 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 04:28:56 INFO - PROCESS | 1925 | colorDepth:24 04:28:56 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 04:28:56 INFO - PROCESS | 1925 | __metrics 04:28:56 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 04:28:57 INFO - TEST-INFO | 1925: exit 0 04:28:57 INFO - Browser initialized. 04:28:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:57 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpNmTjLL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:09 INFO - PROCESS | 1928 | RSS: Main: 225017856 04:29:09 INFO - PROCESS | 1928 | 04:29:58 INFO - PROCESS | 1928 | 1476358198899 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] 04:32:10 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53405/tests/dromaeo/cssquery-ext.html) 04:32:12 INFO - PROCESS | 1928 | RSS: Main: 236871680 04:32:12 INFO - PROCESS | 1928 | 04:35:14 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-ext.html (next: http://localhost:53405/tests/dromaeo/cssquery-jquery.html) 04:35:15 INFO - PROCESS | 1928 | RSS: Main: 247922688 04:35:15 INFO - PROCESS | 1928 | 04:38:17 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53405/tests/dromaeo/cssquery-mootools.html) 04:38:17 INFO - PROCESS | 1928 | RSS: Main: 251576320 04:38:17 INFO - PROCESS | 1928 | 04:41:19 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53405/tests/dromaeo/cssquery-prototype.html) 04:41:20 INFO - PROCESS | 1928 | RSS: Main: 251916288 04:41:20 INFO - PROCESS | 1928 | 04:44:22 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53405/tests/dromaeo/cssquery-yui.html) 04:44:23 INFO - PROCESS | 1928 | RSS: Main: 257232896 04:44:23 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:53405/tests/dromaeo/cssquery-yui.html (next: http://localhost:53405/tests/dromaeo/cssquery-dojo.html) 04:47:26 INFO - PROCESS | 1928 | RSS: Main: 258572288 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | __start_tp_report 04:47:26 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 04:47:26 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 04:47:26 INFO - PROCESS | 1928 | |i|pagename|runs| 04:47:26 INFO - PROCESS | 1928 | |0;dojo.html;2866.2977570495227;3470.149813295743;3475.0269924421173;3507.9298414031705;3525.242072954315;4790.904181916359;5957.910631340528;5998.910016349758;6032.366601506845;6045.546584006195;5964.79123230687;6012.3687012863675;6023.969880150593;6070.969645151779;6078.20983272174;5392.272043274166;5415.620906536544;5432.049391356517;5451.781928722866;5513.8345849624375;5452.045891968909;5475.7262136893;5482.793785367213;5494.423085576017;5495.422980587041;5349.465053494639;5370.221317908901;5478.068728316176;5483.862903427406;5522.475364840334;5410.540104091137;5416.702081385522;5457.945420545783;5476;5547.44525547442;5325.600579956519;5422.91865622016;5456.972715136399;5459.208414779874;5465.9180112298345;5826.359100498942;5979.671118088503;6058.757649694007;6116.052011938156;6122.54080943931;6051.78964207156;6167.475764559973;6224.470919971808;6276.497880169622;6361.55469117162;6438.903416448757;6474.579152355129;6481.708323125471;6494.902576461357;6500.772472963424;5948.10778383246;6116.694165291762;6121.663308517986;6133.018717005347;6133.294671112834;5703.54371650267;6404.455621272151;6410.61536307823;6424.775132870327;6454.644994525346;6226.377362263828;6233.657148856766;6289.182406287154;6297.842553936188;6307.968460157762;6401.807945761635;6408.775692850728;6428.8071357859335;6430.678466076677;6449.645269510128;6190.226221722285;6191.102290167901;6236.937630623726;6254.781082662085;6264.874702505925;6302.1492098566105;6326;6331.430171284606;6345.7144428499905;6348.650824204621;5103.362079740033;5106.693598384035;5109.105906466353;5120.692758434431;5124.615653825978;4430.424044874146;4476.194285028726;4491.550844915482;4512.909741805145;4580.610648094883;6131.713108457284;6168.352323006109;6171.56799024064;6172.166757487771;6180.227471566054;6476.708548115346;6486.35136486357;6490.286068532458;6490.350964903472;6490.415862572391;4956.727379994135;4968.726720030433;5811.88376232473;5997.460228579449;6131.835460087213;4483.686141970096;5615.943840561542;5620.887582248332;5624.268845050117;5627.380988091307;5521.00621888064;6602.60384376939;6621.172353455818;6629.602223866584;6633.767818126343;6234.127222188988;6290.654014029089;6330.272018717722;6429.292777794532;6490.318516555693;5585.1901474286815;6432.742690292336;6634.270230274569;6656.334366563305;6662.233843107911;6337.397947195009;6344.746210151542;6352.9047064295;6359.936400635935;6365.649889256136;6198.287196972406;6282.963311053808;6405.231372235362;6430.7749228776765;6471.320511346241;5075.5178258065425;5196.4283928767045;6200.627962322275;6291.433770960635;6303.621782693053;5396.9190462142315;6275.497960163268;6281.685915704288;6303.338149494421;6303.747850085945;5968.641881487125;6019.398060193946;6122.173506576555;6169.629822210682;6230.719617617308;6164.229471316085;6197.194364732556;6212.4408803207925;6227;6269.185005949197;6152.78465253714;6184.226971628546;6187.504999599932;6197.845053873509;6213.471854892204 04:47:26 INFO - PROCESS | 1928 | |1;ext.html;443.3283575383295;463.87243508035306;517.2138349708441;518.1761000009983;538.1094288951783;40827.79586102069;43844.780776096115;43883;43884.561154388444;43885.12229755403;43917.560824391745;44225.55774442263;44530;44857.7757111214;44983.77508112455;8503.914960850405;9894.455804930725;10087.344322619043;10093.243006774484;10114.342567733074;9892.653757118502;10002.749931251741;10004.249681273897;10004.499775011256;10026.09765121139;9979.700608981706;10012.249081318894;10024.097831195191;10040.949795251014;10050.396976181415;9926.05702458269;9992.100710935978;10006;10014.49927503622;10018.39889606626;9888.555015024342;9987.700368988943;9990.200783937267;10003.549840257207;10009.29934904557;41308.58691413078;41967.160656787;42181.367279490834;42300.788496057634;42543.57456425427;3249.1877030742316;3473.4095203815414;3752.906177345561;3796.5633952095586;3920.921581568353;31239;31432.58553365104;31441;31546.684533154603;31877.840610796797;3191.6010498687665;3198.5362122492106;3305.652906444837;3321.0036988903476;3338.115399419156;382163;385240;386538;386764.9999999972;387027.9999999972;63594;63645.68177159085;63985;64399;64417.67791161108;35717.46423803645;36124.63875361266;36511.81744091315;37661;64251.03623445652;17330;17354.739678904825;17417.21622526964;17482.475525734248;17491;11141.2201145919;11180.496877640526;12553.874461255453;13048.1518701286;13193.20840749558;19267.586543684112;19647.60704785925;19700.31048913281;19700.90149549243;19764.40706778799;6830.267892842902;8032.39757018226;8049.007830685637;8099.595020248964;8165.775133729988;821.9178082191733;912.8630705394111;940.4592359393376;969.9563519641633;1029.325791606499;25017.4996500069;30661.92683256075;30908.69091309103;31456.842715786275;31995.52006719901;940.210223412337;1043.0768769638923;1126.954921803135;1133.8525991621036;1166.4634268236707;16169.272382742805;16366.181690915406;16368.427105051265;16374.099424531527;16652.16739163037;631272;695168;695569;696475;697663;61256.38743612596;61734.765304693654;61747.07379389313;61859.07211391833;61957.38042619516;1332.380443093966;1360.816289800884;1375.628580283318;1378.2901805570139;1383.5019393018706;26084.608730868673;30001.949931752282;30725.692743072283;31177.688223118384;31518.842405787826;53537.73231133819;56754.14868776889;57759;59211.407885922315;62908;501770;502507;507491;507822;511078;44457.77771111124;44867;45154;45488.31767523423;45605;49543.256851147984;50485.747571261905;50873.491265088356;51022.979540409724;57623.42376576181;42115.578844211166;42721;43550.782246088565;44426;45107.77446112748;33634;38001.80999094987;43073.353899690905;43482.34776478292;44492;36893.44659830051;38134.2373152541;42075.7896210517;42433.57566424296;45145;30769.846150769103;35134.64865351314;36628.90113296606;38448;39206;25191.37021574475;27878;27904.883804647587;28160.43679126447;28363.43273134567 04:47:26 INFO - PROCESS | 1928 | |2;jquery.html;322.9838508074596;337.868231389758;347.1390950442902;386.7834012952746;407.95563357804025;13837.723245535084;17528.298868045295;19635.803641963594;20078.397648070546;21118.788812111874;17905.283788648438;19484;19657.70513442296;19994.50013749657;20662.69005964908;4943.728094954785;6042.154098426224;6085.056816193475;6090.756369745227;6107.664078475682;5610.4670056344585;5886.852828679296;5949.434803693643;5984.431479009487;5990.371011043843;5967.283925928895;5975.163477113208;5975.820725378246;5976.163337132805;5983.10253461982;7475.73834915778;7850.646720897574;7900.920990790076;7912.881306780403;7948.165442628557;7337.395224695209;7569.583672897988;7656.578888161149;7677.270659287359;7681.73113941015;27647.723522764714;28490.715092849012;28619.85690071557;28957.71042289571;29412.411751764845;2477.4606773980286;2562.782163516085;2576.9226923192336;2656.3226377273863;2763.571646394812;16722.66554668912;16885.74671379918;17026.91486542572;17248.310067597282;18079.91520508774;1619.5627180661156;1887.9244830206912;1937.6318499485053;2003.9799602003939;2010.6179825833044;117499;119409;124164.37917810444;154442;158962;21405.78594214038;22035;22145;22224.55550888973;22285.331440056823;36235.27529449449;36411.63588364136;36757.632423675954;37029.88910332695;37095.258094837955;9981.850272245922;10928.617498387519;11171.72070698239;11362.94318528402;11415.37215453158;9009.504477253682;9056;9219.631214751469;9361.485118318558;9370.484623345645;9805.558749856273;9844.621752954592;9906.55420506079;10071.992800720016;10113.848292275621;2930.9267268318035;2991.730744232986;3715.6655900969045;3880.689544836406;3915.256101340736;845.3786466946789;931.2549960031947;961.3558915526614;964.62379671928;981.6466072213997;20175.4956126098;20597.89701051485;20791.272305469236;21072.473188170112;21091.261805837028;759.343168159538;821.8767184922309;925.486355072941;928.475411392561;956.416585882611;9571.521423928776;10952.726181845517;11003.61487347939;11037.227394082498;11118.777624447628;606467;613164;617447;624774;625586;68733.65633171902;72923.63538182275;108468.4576577112;117648.8235117655;141612.583874162;809.3929552835256;860.7805009722606;931.2549960032082;979.8089372572423;985.7584891701579;17253.878497897596;17556.648867022333;19136.660433769503;19415.4175374739;19426.514337141685;48644;52616.94766104733;52783.94432111413;53878;54450;56895.71552142213;59918;63957.68021159864;66264;74371;7920.485168464032;7996.360291176576;8076.353891688534;8174.059983102019;8372.539510326991;9141.908580914105;11684.591039313584;12747.362631868184;12972.870271297166;13140.474381024653;11006.504707288352;11459.942700286445;11517;11590.884091159318;11647.010004149743;10820.67537973862;11003.724906877393;11135.33188008722;11219.887801122211;11364.408982742589;10649.668791401074;11413.543458261576;11494;11510.42447877586;11586.942065289619;7803.648835802289;7956.085050219067;8099.5545245009735;8198.631061602124;8254.174582541698;10726.624568140078;10802.919708029134;11373.976342129248;11517.136214784092;11998.940005299917 04:47:26 INFO - PROCESS | 1928 | |3;mootools.html;1469.5517867050548;1516.840731723169;1729.1786401459308;1846.2891786662149;1895.4408449507384;8058.234467725571;8288.70989515367;8451.661933522659;9103.95448022759;9111.54442277886;8484;8779.517126558037;8808.691695790649;8876.15676510732;8907.331950103735;2391.127238557927;2413.698287714036;2416.649585810065;2423.769741874528;2425.163318655061;2356.9764302357016;2382;2395.964060539093;2397.7242617098996;2401.819863510235;2381.142788596104;2387.403149212697;2398.8440751351195;2417.0331867253153;2423.2245681381964;2371.6205407134776;2377.7741114594173;2384.6899903012586;2390.6772585700883;2394.5570069537102;2359.256834097254;2365.929022129339;2376.584097782881;2380.262118743195;2385.1294277588554;8943.910560894437;9110.772230694285;9118.635254589808;9130.041345658676;9133.223675987549;5330.813421530266;5502.532284755801;5505.174223866412;5516.365617953947;5556.611037227396;2907.302247460594;3286.4905939579403;3345.3476572068457;3610.772337405295;3680.5583330000304;983.955721992512;1083.8807731149568;1097.5774326884127;1126.121625132398;1134.6199023327194;11891.464884080237;11931.761364772656;12029.458674359676;12060.336681482428;12074.577389791315;4049.8380064797666;4667.883302917454;4798.640101992364;4893.657443978958;4931.5315045070665;10125.443100629536;10204.897951020395;10208.948955255177;10233.181345492343;10248;4634.83778067766;5329.907368989348;5414.187871819258;5483.232347471358;5498.202760599771;4463.24124898768;4630.83792067276;4841.1285968526;4987.476314986947;5051.090803655304;3998.5801490843623;4045;4095.4266402703647;4114.897127571775;4138.689598280141;1297.9286139262242;1301.1087405127519;1312.5799744081994;1318.8747069028427;1320.2936429010626;820.7578764264556;900.6127365233012;914.3645166609276;917.5045475443186;928.9814203716023;5734.598578099576;5912.733926973297;5913.704314784243;5942;6096.055111457731;445.692472194185;450.61022215783765;452.23120694818937;941.463365881441;992.156666833186;3906.5312162540677;3924.372100463969;3933.8623148189677;3961.960380396159;4038.5759495253164;10696.89303106959;11046.281991670516;11062.557497700001;11067.778644427228;11088.611898583511;10835;10904.454777261106;11012.779744405227;11017.410908436512;11125.666230013112;8264.586770661443;8381.790455238668;8386.79033024167;8494.915050849413;8502.829943401097;5702.800401985911;5769.134629805562;5859.2382990211;5868.970655146697;5918.763249469973;9842.556895908469;9973.950130249303;10178.592856285963;10217.080462758388;10242.539085741011;10207.387556746618;10208.132308753542;10325.225608079274;10388.584456621651;10526.157907367238;7046.718131274896;7204.3155900189395;7631.503952243309;7637.159912409742;7775;8552.486850788973;8570.700025499078;8626.482411055356;8643.740687779376;8657.653693852175;7472.40220782347;7546.019017527687;7630.198829122862;7750.7674769756995;7777.300042996158;7446.180920098893;7553.244675532403;7568.924310756822;7580.772576822704;7594.240575942362;6968.547044442095;7097.183823860116;7098.041764361745;7113.57318560888;7123.857522849617;4238.406623072834;4957.305977163128;4964.826231081895;4997.275395067622;5042.495750424928;5004.324416203912;5058.799422251185;5101.693898365961;5116.258142569381;5141.5629671476845 04:47:26 INFO - PROCESS | 1928 | |4;prototype.html;266.5016419295917;301.9396120775845;312.8154388910542;318.6701763674597;319.6867070271133;4658.440987081551;4842.2252439609665;5576.944230557693;5722.771089156434;5732.627379220347;4906.582940450066;5344.118220493614;5557.3331200256025;5561.63849349793;5566.075916478882;3659.652333028365;3686.3733165361955;4250.341197114452;4271.5301316855275;4277.230098582254;4134.338505839067;4259.700791258665;4286.935695964563;4291.262038874261;4298.183345164409;4177;4188.874333769992;4201.579842015789;4203.453551038361;4204.5585213552595;3551.058969373118;4160.337384074195;4251.149770046003;4254.532001479834;4262.424572682679;3102.4105419970133;3690.317291301118;3690.464882592036;3692.8921323602813;3698.4082546792383;5101.566366858821;5330.813421530266;5337.386200586943;5394.163904594794;5441.020616289066;4431.645468362555;4896.608271338285;4918.163912134945;4930.2251189571725;4940.25896115582;5498.752556134984;5908.822735317947;5910.497607703351;5920.703964801743;5975.312839023524;3470.774399664039;3711;3715.925681486355;3956.5647778744315;3970.8484539483516;5242.2136679498;6142.6314421134875;6193.938060619381;6203.161534003484;6211.534134939898;3781.6029316921877;3899.908025752794;4004.239194553084;4011.8194681239415;4021.4463815477384;3024.9546256806166;3541.6635419635095;3551.6448355164794;4005.639492445694;4079.1841631673783;4255.829766809355;4595.701279416827;4697.271922851964;4812.374391329105;4829.7881908531135;4595.310703394518;5267.9427749360275;5334.333208348957;5381.300430943952;5871.647701137946;1270.358468973181;1294.9028822838325;1353.4315587453293;1358.2325985817981;1363.8022486739565;767.9385649148167;790.9644066017044;820.2125959079232;831.4470876866936;840.7477756672973;4127.607877251657;4304.999999999937;4490.575089451725;4589;4778.808847646055;4187.5184353799095;4375.824967001285;4468.843590474317;5128.615353848401;5142.30578871855;4014.1570270243574;4157.563455837154;4198.124284864816;4709;4755.38180036593;2454.7913427358517;2560.5903055511403;2560.948781024369;2677.4604602353725;2717.4836781011545;5085.618578606619;5132.820351287687;5301;5321.787128514893;5331.854206018468;4765.451973023147;4771.593855974508;5232.633715639869;5236.292441239068;5291.629585929025;3982.183652351319;4145.54399016108;4501.363595496644;4562.498125206224;5044.495550445;4904.754762261944;5155.355580552431;5160;5160.993606246746;5202.297689811979;4715.363425937455;4933.333999909966;4945.653804233813;5045.419776725576;5110.872228194325;5236.39781425141;5251.343582052244;5252.684838909678;5259.870377125604;5288.471152884681;3517.66582174693;3541.8760343387858;3544.5037694723273;3553.2715793262837;3580;4187;4330.069035157457;5014.824481143289;5096.388433388017;5143.3570803649545;4916.631252656137;5145.45972672864;5940.6435613863305;5947.434993675594;5962.731677074456;4680.976595117003;5942.940570594412;5960.407222858071;5963.612365196248;5973.223480947449;5445.237666726741;5565.860853478695;5634.971825140848;5720.8283751487525;5783.508401785895;5891.734871930687;5928.703564821828;5972.193753843349;5975.492083172805;5981.859523749892;5524.784547399727;5842.298924129132;5852.356240813592;5855.853603659943;5897.970510147422 04:47:26 INFO - PROCESS | 1928 | |5;yui.html;686.2417029182753;771.9421043421742;776.879583664532;797.8484088023272;799.4221997961868;15310.923445382772;15701.450449234264;15720;15731.764023539656;15750.448734294301;14031.29843507823;14048.64878378041;14050.578482645511;14084.29578521075;14140.151590904554;636.4590098416355;674.5817593092289;790.6916302641974;823.1603764160568;830.2237408023517;675.4663815585682;699.6671341095222;809.352517985612;845.0662018469595;847.9703210387638;886.5744442667524;893.7408151636017;898.4025622960723;910.4901255297021;910.7814124610112;893.7542175901614;897.1521911793358;900.3292547052488;902.842002649537;905.7780843693305;655.298830251631;667.9899801502982;668.5086461450829;668.8261052126434;670.179030687409;13656;14798.334074966544;14837;14889.553313400615;15002.699946001128;14558.92720536401;14640.121592704472;14656;14666.19335936523;14678.412863485448;9539.427634341962;11709.063274937984;12048.277103373826;12135.93932030343;12270.631881043582;3777.471154038437;3813.0848596336955;3847.4421208924828;3891.182851601167;3893.6885049196;114812;116333.83666163315;117127;117218;118227;11039;11153.888461115448;11225;11304.321740695585;11695.239809412362;23363.415914602272;23543.88228058849;23815.642765358534;23853.403664908168;23946;7883.251091146332;7928.929594504783;7987.3610111190965;8030.759077227693;8068.919310806934;3740.251949610089;4365.126974605092;4521.389612402284;4549.909001819945;4629.884252893705;3498.930021399558;3573.5890372606964;3610.332088563624;3617.565892092966;3620.0768803954825;631.2897989761518;650.3431534150448;653.017209100301;661.7551505942832;666.6799936030733;636.2047440699126;660.1780782925289;660.9107770451023;679.7688785812848;685.873113474009;8166.305864001508;9072.27421806254;9413;9550.997145299782;9585.897621773445;505.7875692209281;524.3969435149609;540.497337476151;598.7335635642097;624.5565648389694;4466.620337271368;4578.106785959798;4614.538546145359;4637.837675681402;4766.76166191689;141549.87675184882;144459.2777036129;147752;158457.4154258466;159309;129561;131785;135518.32240838732;135617;140517;120002.39998800124;121490.39254803669;122571;124511.75488245183;124958.37520812338;6963.850964590786;8622.396432249683;8637.352198585006;8719.956400217958;9276.62893484253;47555;54765.452345476035;57363.85272294447;65064.34935650772;65746.67126664336;58885.705571471866;59633;97020.51489742506;102161;104562;8996.460212387277;11217.046551043253;11242.594675665541;11636.185467017227;11998.100142489522;12186.573469928864;12189.207701499374;12311.56909508163;12408;12545.243665886966;11415.771684566096;11530;11887.465064071965;11968.281903085843;12416.75166496683;9840.950795245977;10825.133989280996;12084.214526055779;12099.213551119148;12654.114212005072;8623.439476434012;11539.826902596637;11677.824832627348;11933.28400295985;11972.443582334241;8564.914350856412;9756.512174391393;9909;9933.106020458194;10201.948990255001;6406.903896441464;8767.123287671182;8890.110988901317;8957.14907083826;9016.459012459274 04:47:26 INFO - PROCESS | 1928 | __end_tp_report 04:47:26 INFO - PROCESS | 1928 | __start_cc_report 04:47:26 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,365 04:47:26 INFO - PROCESS | 1928 | __end_cc_report 04:47:26 INFO - PROCESS | 1928 | __startTimestamp1476359246368__endTimestamp 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | ------- Summary: start ------- 04:47:26 INFO - PROCESS | 1928 | Number of tests: 6 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5887.06 Median:6164.23 stddev:682.25 (11.1%) stddev-sans-first:641.87 04:47:26 INFO - PROCESS | 1928 | Values: 2866.3 3470.1 3475.0 3507.9 3525.2 4790.9 5957.9 5998.9 6032.4 6045.5 5964.8 6012.4 6024.0 6071.0 6078.2 5392.3 5415.6 5432.0 5451.8 5513.8 5452.0 5475.7 5482.8 5494.4 5495.4 5349.5 5370.2 5478.1 5483.9 5522.5 5410.5 5416.7 5457.9 5476.0 5547.4 5325.6 5422.9 5457.0 5459.2 5465.9 5826.4 5979.7 6058.8 6116.1 6122.5 6051.8 6167.5 6224.5 6276.5 6361.6 6438.9 6474.6 6481.7 6494.9 6500.8 5948.1 6116.7 6121.7 6133.0 6133.3 5703.5 6404.5 6410.6 6424.8 6454.6 6226.4 6233.7 6289.2 6297.8 6308.0 6401.8 6408.8 6428.8 6430.7 6449.6 6190.2 6191.1 6236.9 6254.8 6264.9 6302.1 6326.0 6331.4 6345.7 6348.7 5103.4 5106.7 5109.1 5120.7 5124.6 4430.4 4476.2 4491.6 4512.9 4580.6 6131.7 6168.4 6171.6 6172.2 6180.2 6476.7 6486.4 6490.3 6490.4 6490.4 4956.7 4968.7 5811.9 5997.5 6131.8 4483.7 5615.9 5620.9 5624.3 5627.4 5521.0 6602.6 6621.2 6629.6 6633.8 6234.1 6290.7 6330.3 6429.3 6490.3 5585.2 6432.7 6634.3 6656.3 6662.2 6337.4 6344.7 6352.9 6359.9 6365.6 6198.3 6283.0 6405.2 6430.8 6471.3 5075.5 5196.4 6200.6 6291.4 6303.6 5396.9 6275.5 6281.7 6303.3 6303.7 5968.6 6019.4 6122.2 6169.6 6230.7 6164.2 6197.2 6212.4 6227.0 6269.2 6152.8 6184.2 6187.5 6197.8 6213.5 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:67821.08 Median:386896.50 stddev:143971.88 (37.2%) stddev-sans-first:144286.88 04:47:26 INFO - PROCESS | 1928 | Values: 443.3 463.9 517.2 518.2 538.1 40827.8 43844.8 43883.0 43884.6 43885.1 43917.6 44225.6 44530.0 44857.8 44983.8 8503.9 9894.5 10087.3 10093.2 10114.3 9892.7 10002.7 10004.2 10004.5 10026.1 9979.7 10012.2 10024.1 10040.9 10050.4 9926.1 9992.1 10006.0 10014.5 10018.4 9888.6 9987.7 9990.2 10003.5 10009.3 41308.6 41967.2 42181.4 42300.8 42543.6 3249.2 3473.4 3752.9 3796.6 3920.9 31239.0 31432.6 31441.0 31546.7 31877.8 3191.6 3198.5 3305.7 3321.0 3338.1 382163.0 385240.0 386538.0 386765.0 387028.0 63594.0 63645.7 63985.0 64399.0 64417.7 35717.5 36124.6 36511.8 37661.0 64251.0 17330.0 17354.7 17417.2 17482.5 17491.0 11141.2 11180.5 12553.9 13048.2 13193.2 19267.6 19647.6 19700.3 19700.9 19764.4 6830.3 8032.4 8049.0 8099.6 8165.8 821.9 912.9 940.5 970.0 1029.3 25017.5 30661.9 30908.7 31456.8 31995.5 940.2 1043.1 1127.0 1133.9 1166.5 16169.3 16366.2 16368.4 16374.1 16652.2 631272.0 695168.0 695569.0 696475.0 697663.0 61256.4 61734.8 61747.1 61859.1 61957.4 1332.4 1360.8 1375.6 1378.3 1383.5 26084.6 30001.9 30725.7 31177.7 31518.8 53537.7 56754.1 57759.0 59211.4 62908.0 501770.0 502507.0 507491.0 507822.0 511078.0 44457.8 44867.0 45154.0 45488.3 45605.0 49543.3 50485.7 50873.5 51023.0 57623.4 42115.6 42721.0 43550.8 44426.0 45107.8 33634.0 38001.8 43073.4 43482.3 44492.0 36893.4 38134.2 42075.8 42433.6 45145.0 30769.8 35134.6 36628.9 38448.0 39206.0 25191.4 27878.0 27904.9 28160.4 28363.4 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:36421.43 Median:342.50 stddev:102494.42 (29925.1%) stddev-sans-first:102746.10 04:47:26 INFO - PROCESS | 1928 | Values: 323.0 337.9 347.1 386.8 408.0 13837.7 17528.3 19635.8 20078.4 21118.8 17905.3 19484.0 19657.7 19994.5 20662.7 4943.7 6042.2 6085.1 6090.8 6107.7 5610.5 5886.9 5949.4 5984.4 5990.4 5967.3 5975.2 5975.8 5976.2 5983.1 7475.7 7850.6 7900.9 7912.9 7948.2 7337.4 7569.6 7656.6 7677.3 7681.7 27647.7 28490.7 28619.9 28957.7 29412.4 2477.5 2562.8 2576.9 2656.3 2763.6 16722.7 16885.7 17026.9 17248.3 18079.9 1619.6 1887.9 1937.6 2004.0 2010.6 117499.0 119409.0 124164.4 154442.0 158962.0 21405.8 22035.0 22145.0 22224.6 22285.3 36235.3 36411.6 36757.6 37029.9 37095.3 9981.9 10928.6 11171.7 11362.9 11415.4 9009.5 9056.0 9219.6 9361.5 9370.5 9805.6 9844.6 9906.6 10072.0 10113.8 2930.9 2991.7 3715.7 3880.7 3915.3 845.4 931.3 961.4 964.6 981.6 20175.5 20597.9 20791.3 21072.5 21091.3 759.3 821.9 925.5 928.5 956.4 9571.5 10952.7 11003.6 11037.2 11118.8 606467.0 613164.0 617447.0 624774.0 625586.0 68733.7 72923.6 108468.5 117648.8 141612.6 809.4 860.8 931.3 979.8 985.8 17253.9 17556.6 19136.7 19415.4 19426.5 48644.0 52616.9 52783.9 53878.0 54450.0 56895.7 59918.0 63957.7 66264.0 74371.0 7920.5 7996.4 8076.4 8174.1 8372.5 9141.9 11684.6 12747.4 12972.9 13140.5 11006.5 11459.9 11517.0 11590.9 11647.0 10820.7 11003.7 11135.3 11219.9 11364.4 10649.7 11413.5 11494.0 11510.4 11586.9 7803.6 7956.1 8099.6 8198.6 8254.2 10726.6 10802.9 11374.0 11517.1 11998.9 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5796.63 Median:4733.26 stddev:3295.27 (69.6%) stddev-sans-first:3288.47 04:47:26 INFO - PROCESS | 1928 | Values: 1469.6 1516.8 1729.2 1846.3 1895.4 8058.2 8288.7 8451.7 9104.0 9111.5 8484.0 8779.5 8808.7 8876.2 8907.3 2391.1 2413.7 2416.6 2423.8 2425.2 2357.0 2382.0 2396.0 2397.7 2401.8 2381.1 2387.4 2398.8 2417.0 2423.2 2371.6 2377.8 2384.7 2390.7 2394.6 2359.3 2365.9 2376.6 2380.3 2385.1 8943.9 9110.8 9118.6 9130.0 9133.2 5330.8 5502.5 5505.2 5516.4 5556.6 2907.3 3286.5 3345.3 3610.8 3680.6 984.0 1083.9 1097.6 1126.1 1134.6 11891.5 11931.8 12029.5 12060.3 12074.6 4049.8 4667.9 4798.6 4893.7 4931.5 10125.4 10204.9 10208.9 10233.2 10248.0 4634.8 5329.9 5414.2 5483.2 5498.2 4463.2 4630.8 4841.1 4987.5 5051.1 3998.6 4045.0 4095.4 4114.9 4138.7 1297.9 1301.1 1312.6 1318.9 1320.3 820.8 900.6 914.4 917.5 929.0 5734.6 5912.7 5913.7 5942.0 6096.1 445.7 450.6 452.2 941.5 992.2 3906.5 3924.4 3933.9 3962.0 4038.6 10696.9 11046.3 11062.6 11067.8 11088.6 10835.0 10904.5 11012.8 11017.4 11125.7 8264.6 8381.8 8386.8 8494.9 8502.8 5702.8 5769.1 5859.2 5869.0 5918.8 9842.6 9974.0 10178.6 10217.1 10242.5 10207.4 10208.1 10325.2 10388.6 10526.2 7046.7 7204.3 7631.5 7637.2 7775.0 8552.5 8570.7 8626.5 8643.7 8657.7 7472.4 7546.0 7630.2 7750.8 7777.3 7446.2 7553.2 7568.9 7580.8 7594.2 6968.5 7097.2 7098.0 7113.6 7123.9 4238.4 4957.3 4964.8 4997.3 5042.5 5004.3 5058.8 5101.7 5116.3 5141.6 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:4434.94 Median:4836.01 stddev:1375.16 (28.4%) stddev-sans-first:1342.95 04:47:26 INFO - PROCESS | 1928 | Values: 266.5 301.9 312.8 318.7 319.7 4658.4 4842.2 5576.9 5722.8 5732.6 4906.6 5344.1 5557.3 5561.6 5566.1 3659.7 3686.4 4250.3 4271.5 4277.2 4134.3 4259.7 4286.9 4291.3 4298.2 4177.0 4188.9 4201.6 4203.5 4204.6 3551.1 4160.3 4251.1 4254.5 4262.4 3102.4 3690.3 3690.5 3692.9 3698.4 5101.6 5330.8 5337.4 5394.2 5441.0 4431.6 4896.6 4918.2 4930.2 4940.3 5498.8 5908.8 5910.5 5920.7 5975.3 3470.8 3711.0 3715.9 3956.6 3970.8 5242.2 6142.6 6193.9 6203.2 6211.5 3781.6 3899.9 4004.2 4011.8 4021.4 3025.0 3541.7 3551.6 4005.6 4079.2 4255.8 4595.7 4697.3 4812.4 4829.8 4595.3 5267.9 5334.3 5381.3 5871.6 1270.4 1294.9 1353.4 1358.2 1363.8 767.9 791.0 820.2 831.4 840.7 4127.6 4305.0 4490.6 4589.0 4778.8 4187.5 4375.8 4468.8 5128.6 5142.3 4014.2 4157.6 4198.1 4709.0 4755.4 2454.8 2560.6 2560.9 2677.5 2717.5 5085.6 5132.8 5301.0 5321.8 5331.9 4765.5 4771.6 5232.6 5236.3 5291.6 3982.2 4145.5 4501.4 4562.5 5044.5 4904.8 5155.4 5160.0 5161.0 5202.3 4715.4 4933.3 4945.7 5045.4 5110.9 5236.4 5251.3 5252.7 5259.9 5288.5 3517.7 3541.9 3544.5 3553.3 3580.0 4187.0 4330.1 5014.8 5096.4 5143.4 4916.6 5145.5 5940.6 5947.4 5962.7 4681.0 5942.9 5960.4 5963.6 5973.2 5445.2 5565.9 5635.0 5720.8 5783.5 5891.7 5928.7 5972.2 5975.5 5981.9 5524.8 5842.3 5852.4 5855.9 5898.0 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:24915.73 Median:4415.87 stddev:41254.22 (934.2%) stddev-sans-first:41329.84 04:47:26 INFO - PROCESS | 1928 | Values: 686.2 771.9 776.9 797.8 799.4 15310.9 15701.5 15720.0 15731.8 15750.4 14031.3 14048.6 14050.6 14084.3 14140.2 636.5 674.6 790.7 823.2 830.2 675.5 699.7 809.4 845.1 848.0 886.6 893.7 898.4 910.5 910.8 893.8 897.2 900.3 902.8 905.8 655.3 668.0 668.5 668.8 670.2 13656.0 14798.3 14837.0 14889.6 15002.7 14558.9 14640.1 14656.0 14666.2 14678.4 9539.4 11709.1 12048.3 12135.9 12270.6 3777.5 3813.1 3847.4 3891.2 3893.7 114812.0 116333.8 117127.0 117218.0 118227.0 11039.0 11153.9 11225.0 11304.3 11695.2 23363.4 23543.9 23815.6 23853.4 23946.0 7883.3 7928.9 7987.4 8030.8 8068.9 3740.3 4365.1 4521.4 4549.9 4629.9 3498.9 3573.6 3610.3 3617.6 3620.1 631.3 650.3 653.0 661.8 666.7 636.2 660.2 660.9 679.8 685.9 8166.3 9072.3 9413.0 9551.0 9585.9 505.8 524.4 540.5 598.7 624.6 4466.6 4578.1 4614.5 4637.8 4766.8 141549.9 144459.3 147752.0 158457.4 159309.0 129561.0 131785.0 135518.3 135617.0 140517.0 120002.4 121490.4 122571.0 124511.8 124958.4 6963.9 8622.4 8637.4 8720.0 9276.6 47555.0 54765.5 57363.9 65064.3 65746.7 58885.7 59633.0 97020.5 102161.0 104562.0 8996.5 11217.0 11242.6 11636.2 11998.1 12186.6 12189.2 12311.6 12408.0 12545.2 11415.8 11530.0 11887.5 11968.3 12416.8 9841.0 10825.1 12084.2 12099.2 12654.1 8623.4 11539.8 11677.8 11933.3 11972.4 8564.9 9756.5 9909.0 9933.1 10201.9 6406.9 8767.1 8890.1 8957.1 9016.5 04:47:26 INFO - PROCESS | 1928 | -------- Summary: end -------- 04:47:26 INFO - PROCESS | 1928 | 04:47:26 INFO - TEST-INFO | 1928: exit 0 04:47:26 INFO - TEST-OK | dromaeo_css | took 1113155ms 04:47:26 INFO - TEST-START | kraken 04:47:26 INFO - operating with platform_type : mac_ 04:47:26 INFO - Initialising browser for kraken test... 04:47:27 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpBTxZNj/profile http://localhost:53405/getInfo.html) 04:47:29 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 04:47:29 INFO - PROCESS | 1936 | colorDepth:24 04:47:29 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 04:47:29 INFO - PROCESS | 1936 | __metrics 04:47:29 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 04:47:30 INFO - TEST-INFO | 1936: exit 0 04:47:30 INFO - Browser initialized. 04:47:30 INFO - Running cycle 1/1 for kraken test... 04:47:30 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpBTxZNj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:42 INFO - PROCESS | 1938 | RSS: Main: 225067008 04:47:42 INFO - PROCESS | 1938 | 04:47:45 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53405/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:46 INFO - PROCESS | 1938 | RSS: Main: 237162496 04:47:46 INFO - PROCESS | 1938 | 04:47:48 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53405/tests/kraken/driver.html?testName=audio-dft) 04:47:49 INFO - PROCESS | 1938 | RSS: Main: 244674560 04:47:49 INFO - PROCESS | 1938 | 04:47:52 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53405/tests/kraken/driver.html?testName=audio-fft) 04:47:53 INFO - PROCESS | 1938 | RSS: Main: 248377344 04:47:53 INFO - PROCESS | 1938 | 04:47:55 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53405/tests/kraken/driver.html?testName=audio-oscillator) 04:47:56 INFO - PROCESS | 1938 | RSS: Main: 249688064 04:47:56 INFO - PROCESS | 1938 | 04:47:58 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:58 INFO - PROCESS | 1938 | RSS: Main: 250130432 04:47:58 INFO - PROCESS | 1938 | 04:48:01 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53405/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:02 INFO - PROCESS | 1938 | RSS: Main: 250900480 04:48:02 INFO - PROCESS | 1938 | 04:48:05 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53405/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:05 INFO - PROCESS | 1938 | RSS: Main: 250884096 04:48:05 INFO - PROCESS | 1938 | 04:48:08 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53405/tests/kraken/driver.html?testName=json-parse-financial) 04:48:09 INFO - PROCESS | 1938 | RSS: Main: 251269120 04:48:09 INFO - PROCESS | 1938 | 04:48:10 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:48:11 INFO - PROCESS | 1938 | RSS: Main: 250875904 04:48:11 INFO - PROCESS | 1938 | 04:48:13 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:48:14 INFO - PROCESS | 1938 | RSS: Main: 250834944 04:48:14 INFO - PROCESS | 1938 | 04:48:16 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:48:16 INFO - PROCESS | 1938 | RSS: Main: 250839040 04:48:16 INFO - PROCESS | 1938 | 04:48:19 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:48:20 INFO - PROCESS | 1938 | RSS: Main: 250916864 04:48:20 INFO - PROCESS | 1938 | 04:48:23 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:48:24 INFO - PROCESS | 1938 | RSS: Main: 251211776 04:48:24 INFO - PROCESS | 1938 | 04:48:25 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:53405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53405/tests/kraken/driver.html?testName=ai-astar) 04:48:26 INFO - PROCESS | 1938 | RSS: Main: 252727296 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | __start_tp_report 04:48:26 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 04:48:26 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 04:48:26 INFO - PROCESS | 1938 | |i|pagename|runs| 04:48:26 INFO - PROCESS | 1938 | |0;ai-astar;107;119;126;127;119;116;116;119;115;117 04:48:26 INFO - PROCESS | 1938 | |1;audio-beat-detection;143;112;127;178;120;113;117;146;140;110 04:48:26 INFO - PROCESS | 1938 | |2;audio-dft;196;200;196;198;244;271;241;204;193;197 04:48:26 INFO - PROCESS | 1938 | |3;audio-fft;72;74;51;77;62;72;74;56;76;72 04:48:26 INFO - PROCESS | 1938 | |4;audio-oscillator;88;69;89;71;69;72;88;77;104;117 04:48:26 INFO - PROCESS | 1938 | |5;imaging-gaussian-blur;78;117;137;85;88;86;89;87;88;85 04:48:26 INFO - PROCESS | 1938 | |6;imaging-darkroom;94;94;121;113;98;95;95;94;120;120 04:48:26 INFO - PROCESS | 1938 | |7;imaging-desaturate;147;149;95;90;91;90;92;92;90;94 04:48:26 INFO - PROCESS | 1938 | |8;json-parse-financial;49;47;85;87;49;51;90;92;75;83 04:48:26 INFO - PROCESS | 1938 | |9;json-stringify-tinderbox;67;88;63;83;80;74;71;69;70;73 04:48:26 INFO - PROCESS | 1938 | |10;stanford-crypto-aes;83;88;83;82;84;84;87;93;80;84 04:48:26 INFO - PROCESS | 1938 | |11;stanford-crypto-ccm;138;135;139;147;160;161;133;138;202;170 04:48:26 INFO - PROCESS | 1938 | |12;stanford-crypto-pbkdf2;168;168;189;158;234;189;221;231;163;164 04:48:26 INFO - PROCESS | 1938 | |13;stanford-crypto-sha256-iterative;68;69;68;67;69;69;67;68;65;68 04:48:26 INFO - PROCESS | 1938 | __end_tp_report 04:48:26 INFO - PROCESS | 1938 | __start_cc_report 04:48:26 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,946 04:48:26 INFO - PROCESS | 1938 | __end_cc_report 04:48:26 INFO - PROCESS | 1938 | __startTimestamp1476359306167__endTimestamp 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | ------- Summary: start ------- 04:48:26 INFO - PROCESS | 1938 | Number of tests: 14 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#0] ai-astar Cycles:10 Average:118.10 Median:119.00 stddev:5.65 (4.7%) stddev-sans-first:4.33 04:48:26 INFO - PROCESS | 1938 | Values: 107.0 119.0 126.0 127.0 119.0 116.0 116.0 119.0 115.0 117.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:133.50 stddev:21.39 (16.0%) stddev-sans-first:22.21 04:48:26 INFO - PROCESS | 1938 | Values: 143.0 112.0 127.0 178.0 120.0 113.0 117.0 146.0 140.0 110.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#2] audio-dft Cycles:10 Average:214.00 Median:202.00 stddev:27.50 (13.6%) stddev-sans-first:28.39 04:48:26 INFO - PROCESS | 1938 | Values: 196.0 200.0 196.0 198.0 244.0 271.0 241.0 204.0 193.0 197.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#3] audio-fft Cycles:10 Average:68.60 Median:73.00 stddev:9.01 (12.3%) stddev-sans-first:9.47 04:48:26 INFO - PROCESS | 1938 | Values: 72.0 74.0 51.0 77.0 62.0 72.0 74.0 56.0 76.0 72.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:74.50 stddev:16.18 (21.7%) stddev-sans-first:17.11 04:48:26 INFO - PROCESS | 1938 | Values: 88.0 69.0 89.0 71.0 69.0 72.0 88.0 77.0 104.0 117.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:86.50 stddev:18.28 (21.1%) stddev-sans-first:18.44 04:48:26 INFO - PROCESS | 1938 | Values: 78.0 117.0 137.0 85.0 88.0 86.0 89.0 87.0 88.0 85.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:94.00 stddev:12.38 (13.2%) stddev-sans-first:12.54 04:48:26 INFO - PROCESS | 1938 | Values: 94.0 94.0 121.0 113.0 98.0 95.0 95.0 94.0 120.0 120.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#7] imaging-desaturate Cycles:10 Average:103.00 Median:91.50 stddev:23.78 (26.0%) stddev-sans-first:19.17 04:48:26 INFO - PROCESS | 1938 | Values: 147.0 149.0 95.0 90.0 91.0 90.0 92.0 92.0 90.0 94.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#8] json-parse-financial Cycles:10 Average:70.80 Median:84.00 stddev:19.31 (23.0%) stddev-sans-first:18.81 04:48:26 INFO - PROCESS | 1938 | Values: 49.0 47.0 85.0 87.0 49.0 51.0 90.0 92.0 75.0 83.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.50 stddev:7.70 (10.5%) stddev-sans-first:7.76 04:48:26 INFO - PROCESS | 1938 | Values: 67.0 88.0 63.0 83.0 80.0 74.0 71.0 69.0 70.0 73.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:3.68 (4.4%) stddev-sans-first:3.84 04:48:26 INFO - PROCESS | 1938 | Values: 83.0 88.0 83.0 82.0 84.0 84.0 87.0 93.0 80.0 84.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:153.50 stddev:21.61 (14.1%) stddev-sans-first:22.30 04:48:26 INFO - PROCESS | 1938 | Values: 138.0 135.0 139.0 147.0 160.0 161.0 133.0 138.0 202.0 170.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.50 Median:189.00 stddev:29.73 (15.7%) stddev-sans-first:30.59 04:48:26 INFO - PROCESS | 1938 | Values: 168.0 168.0 189.0 158.0 234.0 189.0 221.0 231.0 163.0 164.0 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - PROCESS | 1938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 04:48:26 INFO - PROCESS | 1938 | Values: 68.0 69.0 68.0 67.0 69.0 69.0 67.0 68.0 65.0 68.0 04:48:26 INFO - PROCESS | 1938 | -------- Summary: end -------- 04:48:26 INFO - PROCESS | 1938 | 04:48:26 INFO - TEST-INFO | 1938: exit 0 04:48:26 INFO - TEST-OK | kraken | took 59985ms 04:48:26 INFO - SUITE-END | took 1173s 04:48:27 INFO - Completed test suite (00:19:33) 04:48:27 INFO - javascript benchmark 04:48:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7507.70120243271, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2866.2977570495227, 3470.149813295743, 3475.0269924421173, 3507.9298414031705, 3525.242072954315, 4790.904181916359, 5957.910631340528, 5998.910016349758, 6032.366601506845, 6045.546584006195, 5964.79123230687, 6012.3687012863675, 6023.969880150593, 6070.969645151779, 6078.20983272174, 5392.272043274166, 5415.620906536544, 5432.049391356517, 5451.781928722866, 5513.8345849624375, 5452.045891968909, 5475.7262136893, 5482.793785367213, 5494.423085576017, 5495.422980587041, 5349.465053494639, 5370.221317908901, 5478.068728316176, 5483.862903427406, 5522.475364840334, 5410.540104091137, 5416.702081385522, 5457.945420545783, 5476.0, 5547.44525547442, 5325.600579956519, 5422.91865622016, 5456.972715136399, 5459.208414779874, 5465.9180112298345, 5826.359100498942, 5979.671118088503, 6058.757649694007, 6116.052011938156, 6122.54080943931, 6051.78964207156, 6167.475764559973, 6224.470919971808, 6276.497880169622, 6361.55469117162, 6438.903416448757, 6474.579152355129, 6481.708323125471, 6494.902576461357, 6500.772472963424, 5948.10778383246, 6116.694165291762, 6121.663308517986, 6133.018717005347, 6133.294671112834, 5703.54371650267, 6404.455621272151, 6410.61536307823, 6424.775132870327, 6454.644994525346, 6226.377362263828, 6233.657148856766, 6289.182406287154, 6297.842553936188, 6307.968460157762, 6401.807945761635, 6408.775692850728, 6428.8071357859335, 6430.678466076677, 6449.645269510128, 6190.226221722285, 6191.102290167901, 6236.937630623726, 6254.781082662085, 6264.874702505925, 6302.1492098566105, 6326.0, 6331.430171284606, 6345.7144428499905, 6348.650824204621, 5103.362079740033, 5106.693598384035, 5109.105906466353, 5120.692758434431, 5124.615653825978, 4430.424044874146, 4476.194285028726, 4491.550844915482, 4512.909741805145, 4580.610648094883, 6131.713108457284, 6168.352323006109, 6171.56799024064, 6172.166757487771, 6180.227471566054, 6476.708548115346, 6486.35136486357, 6490.286068532458, 6490.350964903472, 6490.415862572391, 4956.727379994135, 4968.726720030433, 5811.88376232473, 5997.460228579449, 6131.835460087213, 4483.686141970096, 5615.943840561542, 5620.887582248332, 5624.268845050117, 5627.380988091307, 5521.00621888064, 6602.60384376939, 6621.172353455818, 6629.602223866584, 6633.767818126343, 6234.127222188988, 6290.654014029089, 6330.272018717722, 6429.292777794532, 6490.318516555693, 5585.1901474286815, 6432.742690292336, 6634.270230274569, 6656.334366563305, 6662.233843107911, 6337.397947195009, 6344.746210151542, 6352.9047064295, 6359.936400635935, 6365.649889256136, 6198.287196972406, 6282.963311053808, 6405.231372235362, 6430.7749228776765, 6471.320511346241, 5075.5178258065425, 5196.4283928767045, 6200.627962322275, 6291.433770960635, 6303.621782693053, 5396.9190462142315, 6275.497960163268, 6281.685915704288, 6303.338149494421, 6303.747850085945, 5968.641881487125, 6019.398060193946, 6122.173506576555, 6169.629822210682, 6230.719617617308, 6164.229471316085, 6197.194364732556, 6212.4408803207925, 6227.0, 6269.185005949197, 6152.78465253714, 6184.226971628546, 6187.504999599932, 6197.845053873509, 6213.471854892204], "value": 5844.5813641275745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.3283575383295, 463.87243508035306, 517.2138349708441, 518.1761000009983, 538.1094288951783, 40827.79586102069, 43844.780776096115, 43883.0, 43884.561154388444, 43885.12229755403, 43917.560824391745, 44225.55774442263, 44530.0, 44857.7757111214, 44983.77508112455, 8503.914960850405, 9894.455804930725, 10087.344322619043, 10093.243006774484, 10114.342567733074, 9892.653757118502, 10002.749931251741, 10004.249681273897, 10004.499775011256, 10026.09765121139, 9979.700608981706, 10012.249081318894, 10024.097831195191, 10040.949795251014, 10050.396976181415, 9926.05702458269, 9992.100710935978, 10006.0, 10014.49927503622, 10018.39889606626, 9888.555015024342, 9987.700368988943, 9990.200783937267, 10003.549840257207, 10009.29934904557, 41308.58691413078, 41967.160656787, 42181.367279490834, 42300.788496057634, 42543.57456425427, 3249.1877030742316, 3473.4095203815414, 3752.906177345561, 3796.5633952095586, 3920.921581568353, 31239.0, 31432.58553365104, 31441.0, 31546.684533154603, 31877.840610796797, 3191.6010498687665, 3198.5362122492106, 3305.652906444837, 3321.0036988903476, 3338.115399419156, 382163.0, 385240.0, 386538.0, 386764.9999999972, 387027.9999999972, 63594.0, 63645.68177159085, 63985.0, 64399.0, 64417.67791161108, 35717.46423803645, 36124.63875361266, 36511.81744091315, 37661.0, 64251.03623445652, 17330.0, 17354.739678904825, 17417.21622526964, 17482.475525734248, 17491.0, 11141.2201145919, 11180.496877640526, 12553.874461255453, 13048.1518701286, 13193.20840749558, 19267.586543684112, 19647.60704785925, 19700.31048913281, 19700.90149549243, 19764.40706778799, 6830.267892842902, 8032.39757018226, 8049.007830685637, 8099.595020248964, 8165.775133729988, 821.9178082191733, 912.8630705394111, 940.4592359393376, 969.9563519641633, 1029.325791606499, 25017.4996500069, 30661.92683256075, 30908.69091309103, 31456.842715786275, 31995.52006719901, 940.210223412337, 1043.0768769638923, 1126.954921803135, 1133.8525991621036, 1166.4634268236707, 16169.272382742805, 16366.181690915406, 16368.427105051265, 16374.099424531527, 16652.16739163037, 631272.0, 695168.0, 695569.0, 696475.0, 697663.0, 61256.38743612596, 61734.765304693654, 61747.07379389313, 61859.07211391833, 61957.38042619516, 1332.380443093966, 1360.816289800884, 1375.628580283318, 1378.2901805570139, 1383.5019393018706, 26084.608730868673, 30001.949931752282, 30725.692743072283, 31177.688223118384, 31518.842405787826, 53537.73231133819, 56754.14868776889, 57759.0, 59211.407885922315, 62908.0, 501770.0, 502507.0, 507491.0, 507822.0, 511078.0, 44457.77771111124, 44867.0, 45154.0, 45488.31767523423, 45605.0, 49543.256851147984, 50485.747571261905, 50873.491265088356, 51022.979540409724, 57623.42376576181, 42115.578844211166, 42721.0, 43550.782246088565, 44426.0, 45107.77446112748, 33634.0, 38001.80999094987, 43073.353899690905, 43482.34776478292, 44492.0, 36893.44659830051, 38134.2373152541, 42075.7896210517, 42433.57566424296, 45145.0, 30769.846150769103, 35134.64865351314, 36628.90113296606, 38448.0, 39206.0, 25191.37021574475, 27878.0, 27904.883804647587, 28160.43679126447, 28363.43273134567], "value": 20632.942576598234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9838508074596, 337.868231389758, 347.1390950442902, 386.7834012952746, 407.95563357804025, 13837.723245535084, 17528.298868045295, 19635.803641963594, 20078.397648070546, 21118.788812111874, 17905.283788648438, 19484.0, 19657.70513442296, 19994.50013749657, 20662.69005964908, 4943.728094954785, 6042.154098426224, 6085.056816193475, 6090.756369745227, 6107.664078475682, 5610.4670056344585, 5886.852828679296, 5949.434803693643, 5984.431479009487, 5990.371011043843, 5967.283925928895, 5975.163477113208, 5975.820725378246, 5976.163337132805, 5983.10253461982, 7475.73834915778, 7850.646720897574, 7900.920990790076, 7912.881306780403, 7948.165442628557, 7337.395224695209, 7569.583672897988, 7656.578888161149, 7677.270659287359, 7681.73113941015, 27647.723522764714, 28490.715092849012, 28619.85690071557, 28957.71042289571, 29412.411751764845, 2477.4606773980286, 2562.782163516085, 2576.9226923192336, 2656.3226377273863, 2763.571646394812, 16722.66554668912, 16885.74671379918, 17026.91486542572, 17248.310067597282, 18079.91520508774, 1619.5627180661156, 1887.9244830206912, 1937.6318499485053, 2003.9799602003939, 2010.6179825833044, 117499.0, 119409.0, 124164.37917810444, 154442.0, 158962.0, 21405.78594214038, 22035.0, 22145.0, 22224.55550888973, 22285.331440056823, 36235.27529449449, 36411.63588364136, 36757.632423675954, 37029.88910332695, 37095.258094837955, 9981.850272245922, 10928.617498387519, 11171.72070698239, 11362.94318528402, 11415.37215453158, 9009.504477253682, 9056.0, 9219.631214751469, 9361.485118318558, 9370.484623345645, 9805.558749856273, 9844.621752954592, 9906.55420506079, 10071.992800720016, 10113.848292275621, 2930.9267268318035, 2991.730744232986, 3715.6655900969045, 3880.689544836406, 3915.256101340736, 845.3786466946789, 931.2549960031947, 961.3558915526614, 964.62379671928, 981.6466072213997, 20175.4956126098, 20597.89701051485, 20791.272305469236, 21072.473188170112, 21091.261805837028, 759.343168159538, 821.8767184922309, 925.486355072941, 928.475411392561, 956.416585882611, 9571.521423928776, 10952.726181845517, 11003.61487347939, 11037.227394082498, 11118.777624447628, 606467.0, 613164.0, 617447.0, 624774.0, 625586.0, 68733.65633171902, 72923.63538182275, 108468.4576577112, 117648.8235117655, 141612.583874162, 809.3929552835256, 860.7805009722606, 931.2549960032082, 979.8089372572423, 985.7584891701579, 17253.878497897596, 17556.648867022333, 19136.660433769503, 19415.4175374739, 19426.514337141685, 48644.0, 52616.94766104733, 52783.94432111413, 53878.0, 54450.0, 56895.71552142213, 59918.0, 63957.68021159864, 66264.0, 74371.0, 7920.485168464032, 7996.360291176576, 8076.353891688534, 8174.059983102019, 8372.539510326991, 9141.908580914105, 11684.591039313584, 12747.362631868184, 12972.870271297166, 13140.474381024653, 11006.504707288352, 11459.942700286445, 11517.0, 11590.884091159318, 11647.010004149743, 10820.67537973862, 11003.724906877393, 11135.33188008722, 11219.887801122211, 11364.408982742589, 10649.668791401074, 11413.543458261576, 11494.0, 11510.42447877586, 11586.942065289619, 7803.648835802289, 7956.085050219067, 8099.5545245009735, 8198.631061602124, 8254.174582541698, 10726.624568140078, 10802.919708029134, 11373.976342129248, 11517.136214784092, 11998.940005299917], "value": 10723.67261661607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.5517867050548, 1516.840731723169, 1729.1786401459308, 1846.2891786662149, 1895.4408449507384, 8058.234467725571, 8288.70989515367, 8451.661933522659, 9103.95448022759, 9111.54442277886, 8484.0, 8779.517126558037, 8808.691695790649, 8876.15676510732, 8907.331950103735, 2391.127238557927, 2413.698287714036, 2416.649585810065, 2423.769741874528, 2425.163318655061, 2356.9764302357016, 2382.0, 2395.964060539093, 2397.7242617098996, 2401.819863510235, 2381.142788596104, 2387.403149212697, 2398.8440751351195, 2417.0331867253153, 2423.2245681381964, 2371.6205407134776, 2377.7741114594173, 2384.6899903012586, 2390.6772585700883, 2394.5570069537102, 2359.256834097254, 2365.929022129339, 2376.584097782881, 2380.262118743195, 2385.1294277588554, 8943.910560894437, 9110.772230694285, 9118.635254589808, 9130.041345658676, 9133.223675987549, 5330.813421530266, 5502.532284755801, 5505.174223866412, 5516.365617953947, 5556.611037227396, 2907.302247460594, 3286.4905939579403, 3345.3476572068457, 3610.772337405295, 3680.5583330000304, 983.955721992512, 1083.8807731149568, 1097.5774326884127, 1126.121625132398, 1134.6199023327194, 11891.464884080237, 11931.761364772656, 12029.458674359676, 12060.336681482428, 12074.577389791315, 4049.8380064797666, 4667.883302917454, 4798.640101992364, 4893.657443978958, 4931.5315045070665, 10125.443100629536, 10204.897951020395, 10208.948955255177, 10233.181345492343, 10248.0, 4634.83778067766, 5329.907368989348, 5414.187871819258, 5483.232347471358, 5498.202760599771, 4463.24124898768, 4630.83792067276, 4841.1285968526, 4987.476314986947, 5051.090803655304, 3998.5801490843623, 4045.0, 4095.4266402703647, 4114.897127571775, 4138.689598280141, 1297.9286139262242, 1301.1087405127519, 1312.5799744081994, 1318.8747069028427, 1320.2936429010626, 820.7578764264556, 900.6127365233012, 914.3645166609276, 917.5045475443186, 928.9814203716023, 5734.598578099576, 5912.733926973297, 5913.704314784243, 5942.0, 6096.055111457731, 445.692472194185, 450.61022215783765, 452.23120694818937, 941.463365881441, 992.156666833186, 3906.5312162540677, 3924.372100463969, 3933.8623148189677, 3961.960380396159, 4038.5759495253164, 10696.89303106959, 11046.281991670516, 11062.557497700001, 11067.778644427228, 11088.611898583511, 10835.0, 10904.454777261106, 11012.779744405227, 11017.410908436512, 11125.666230013112, 8264.586770661443, 8381.790455238668, 8386.79033024167, 8494.915050849413, 8502.829943401097, 5702.800401985911, 5769.134629805562, 5859.2382990211, 5868.970655146697, 5918.763249469973, 9842.556895908469, 9973.950130249303, 10178.592856285963, 10217.080462758388, 10242.539085741011, 10207.387556746618, 10208.132308753542, 10325.225608079274, 10388.584456621651, 10526.157907367238, 7046.718131274896, 7204.3155900189395, 7631.503952243309, 7637.159912409742, 7775.0, 8552.486850788973, 8570.700025499078, 8626.482411055356, 8643.740687779376, 8657.653693852175, 7472.40220782347, 7546.019017527687, 7630.198829122862, 7750.7674769756995, 7777.300042996158, 7446.180920098893, 7553.244675532403, 7568.924310756822, 7580.772576822704, 7594.240575942362, 6968.547044442095, 7097.183823860116, 7098.041764361745, 7113.57318560888, 7123.857522849617, 4238.406623072834, 4957.305977163128, 4964.826231081895, 4997.275395067622, 5042.495750424928, 5004.324416203912, 5058.799422251185, 5101.693898365961, 5116.258142569381, 5141.5629671476845], "value": 4608.0916394576625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.5016419295917, 301.9396120775845, 312.8154388910542, 318.6701763674597, 319.6867070271133, 4658.440987081551, 4842.2252439609665, 5576.944230557693, 5722.771089156434, 5732.627379220347, 4906.582940450066, 5344.118220493614, 5557.3331200256025, 5561.63849349793, 5566.075916478882, 3659.652333028365, 3686.3733165361955, 4250.341197114452, 4271.5301316855275, 4277.230098582254, 4134.338505839067, 4259.700791258665, 4286.935695964563, 4291.262038874261, 4298.183345164409, 4177.0, 4188.874333769992, 4201.579842015789, 4203.453551038361, 4204.5585213552595, 3551.058969373118, 4160.337384074195, 4251.149770046003, 4254.532001479834, 4262.424572682679, 3102.4105419970133, 3690.317291301118, 3690.464882592036, 3692.8921323602813, 3698.4082546792383, 5101.566366858821, 5330.813421530266, 5337.386200586943, 5394.163904594794, 5441.020616289066, 4431.645468362555, 4896.608271338285, 4918.163912134945, 4930.2251189571725, 4940.25896115582, 5498.752556134984, 5908.822735317947, 5910.497607703351, 5920.703964801743, 5975.312839023524, 3470.774399664039, 3711.0, 3715.925681486355, 3956.5647778744315, 3970.8484539483516, 5242.2136679498, 6142.6314421134875, 6193.938060619381, 6203.161534003484, 6211.534134939898, 3781.6029316921877, 3899.908025752794, 4004.239194553084, 4011.8194681239415, 4021.4463815477384, 3024.9546256806166, 3541.6635419635095, 3551.6448355164794, 4005.639492445694, 4079.1841631673783, 4255.829766809355, 4595.701279416827, 4697.271922851964, 4812.374391329105, 4829.7881908531135, 4595.310703394518, 5267.9427749360275, 5334.333208348957, 5381.300430943952, 5871.647701137946, 1270.358468973181, 1294.9028822838325, 1353.4315587453293, 1358.2325985817981, 1363.8022486739565, 767.9385649148167, 790.9644066017044, 820.2125959079232, 831.4470876866936, 840.7477756672973, 4127.607877251657, 4304.999999999937, 4490.575089451725, 4589.0, 4778.808847646055, 4187.5184353799095, 4375.824967001285, 4468.843590474317, 5128.615353848401, 5142.30578871855, 4014.1570270243574, 4157.563455837154, 4198.124284864816, 4709.0, 4755.38180036593, 2454.7913427358517, 2560.5903055511403, 2560.948781024369, 2677.4604602353725, 2717.4836781011545, 5085.618578606619, 5132.820351287687, 5301.0, 5321.787128514893, 5331.854206018468, 4765.451973023147, 4771.593855974508, 5232.633715639869, 5236.292441239068, 5291.629585929025, 3982.183652351319, 4145.54399016108, 4501.363595496644, 4562.498125206224, 5044.495550445, 4904.754762261944, 5155.355580552431, 5160.0, 5160.993606246746, 5202.297689811979, 4715.363425937455, 4933.333999909966, 4945.653804233813, 5045.419776725576, 5110.872228194325, 5236.39781425141, 5251.343582052244, 5252.684838909678, 5259.870377125604, 5288.471152884681, 3517.66582174693, 3541.8760343387858, 3544.5037694723273, 3553.2715793262837, 3580.0, 4187.0, 4330.069035157457, 5014.824481143289, 5096.388433388017, 5143.3570803649545, 4916.631252656137, 5145.45972672864, 5940.6435613863305, 5947.434993675594, 5962.731677074456, 4680.976595117003, 5942.940570594412, 5960.407222858071, 5963.612365196248, 5973.223480947449, 5445.237666726741, 5565.860853478695, 5634.971825140848, 5720.8283751487525, 5783.508401785895, 5891.734871930687, 5928.703564821828, 5972.193753843349, 5975.492083172805, 5981.859523749892, 5524.784547399727, 5842.298924129132, 5852.356240813592, 5855.853603659943, 5897.970510147422], "value": 3995.541862173045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.2417029182753, 771.9421043421742, 776.879583664532, 797.8484088023272, 799.4221997961868, 15310.923445382772, 15701.450449234264, 15720.0, 15731.764023539656, 15750.448734294301, 14031.29843507823, 14048.64878378041, 14050.578482645511, 14084.29578521075, 14140.151590904554, 636.4590098416355, 674.5817593092289, 790.6916302641974, 823.1603764160568, 830.2237408023517, 675.4663815585682, 699.6671341095222, 809.352517985612, 845.0662018469595, 847.9703210387638, 886.5744442667524, 893.7408151636017, 898.4025622960723, 910.4901255297021, 910.7814124610112, 893.7542175901614, 897.1521911793358, 900.3292547052488, 902.842002649537, 905.7780843693305, 655.298830251631, 667.9899801502982, 668.5086461450829, 668.8261052126434, 670.179030687409, 13656.0, 14798.334074966544, 14837.0, 14889.553313400615, 15002.699946001128, 14558.92720536401, 14640.121592704472, 14656.0, 14666.19335936523, 14678.412863485448, 9539.427634341962, 11709.063274937984, 12048.277103373826, 12135.93932030343, 12270.631881043582, 3777.471154038437, 3813.0848596336955, 3847.4421208924828, 3891.182851601167, 3893.6885049196, 114812.0, 116333.83666163315, 117127.0, 117218.0, 118227.0, 11039.0, 11153.888461115448, 11225.0, 11304.321740695585, 11695.239809412362, 23363.415914602272, 23543.88228058849, 23815.642765358534, 23853.403664908168, 23946.0, 7883.251091146332, 7928.929594504783, 7987.3610111190965, 8030.759077227693, 8068.919310806934, 3740.251949610089, 4365.126974605092, 4521.389612402284, 4549.909001819945, 4629.884252893705, 3498.930021399558, 3573.5890372606964, 3610.332088563624, 3617.565892092966, 3620.0768803954825, 631.2897989761518, 650.3431534150448, 653.017209100301, 661.7551505942832, 666.6799936030733, 636.2047440699126, 660.1780782925289, 660.9107770451023, 679.7688785812848, 685.873113474009, 8166.305864001508, 9072.27421806254, 9413.0, 9550.997145299782, 9585.897621773445, 505.7875692209281, 524.3969435149609, 540.497337476151, 598.7335635642097, 624.5565648389694, 4466.620337271368, 4578.106785959798, 4614.538546145359, 4637.837675681402, 4766.76166191689, 141549.87675184882, 144459.2777036129, 147752.0, 158457.4154258466, 159309.0, 129561.0, 131785.0, 135518.32240838732, 135617.0, 140517.0, 120002.39998800124, 121490.39254803669, 122571.0, 124511.75488245183, 124958.37520812338, 6963.850964590786, 8622.396432249683, 8637.352198585006, 8719.956400217958, 9276.62893484253, 47555.0, 54765.452345476035, 57363.85272294447, 65064.34935650772, 65746.67126664336, 58885.705571471866, 59633.0, 97020.51489742506, 102161.0, 104562.0, 8996.460212387277, 11217.046551043253, 11242.594675665541, 11636.185467017227, 11998.100142489522, 12186.573469928864, 12189.207701499374, 12311.56909508163, 12408.0, 12545.243665886966, 11415.771684566096, 11530.0, 11887.465064071965, 11968.281903085843, 12416.75166496683, 9840.950795245977, 10825.133989280996, 12084.214526055779, 12099.213551119148, 12654.114212005072, 8623.439476434012, 11539.826902596637, 11677.824832627348, 11933.28400295985, 11972.443582334241, 8564.914350856412, 9756.512174391393, 9909.0, 9933.106020458194, 10201.948990255001, 6406.903896441464, 8767.123287671182, 8890.110988901317, 8957.14907083826, 9016.459012459274], "value": 7520.340583213648, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 126.0, 127.0, 119.0, 116.0, 116.0, 119.0, 115.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 127.0, 178.0, 120.0, 113.0, 117.0, 146.0, 140.0, 110.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 196.0, 198.0, 244.0, 271.0, 241.0, 204.0, 193.0, 197.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 51.0, 77.0, 62.0, 72.0, 74.0, 56.0, 76.0, 72.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 89.0, 71.0, 69.0, 72.0, 88.0, 77.0, 104.0, 117.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 117.0, 137.0, 85.0, 88.0, 86.0, 89.0, 87.0, 88.0, 85.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 121.0, 113.0, 98.0, 95.0, 95.0, 94.0, 120.0, 120.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 95.0, 90.0, 91.0, 90.0, 92.0, 92.0, 90.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 85.0, 87.0, 49.0, 51.0, 90.0, 92.0, 75.0, 83.0], "value": 70.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 88.0, 63.0, 83.0, 80.0, 74.0, 71.0, 69.0, 70.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 83.0, 82.0, 84.0, 84.0, 87.0, 93.0, 80.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 139.0, 147.0, 160.0, 161.0, 133.0, 138.0, 202.0, 170.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 189.0, 158.0, 234.0, 189.0, 221.0, 231.0, 163.0, 164.0], "value": 188.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 69.0, 69.0, 67.0, 68.0, 65.0, 68.0], "value": 67.8, "unit": "score"}]}]} 04:48:27 INFO - Return code: 0 04:48:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:48:27 ERROR - # TBPL SUCCESS # 04:48:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:27 INFO - 2016-10-13 04:48:27.506 screenresolution[1943:19258] starting screenresolution argv=screenresolution get 04:48:27 INFO - 2016-10-13 04:48:27.509 screenresolution[1943:19258] Display 0: 1600x1200x32@60 04:48:27 INFO - 2016-10-13 04:48:27.515 screenresolution[1944:19261] starting screenresolution argv=screenresolution list 04:48:27 INFO - Available Modes on Display 0 04:48:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:27 INFO - Intel Iris: 04:48:27 INFO - Chipset Model: Intel Iris 04:48:27 INFO - Type: GPU 04:48:27 INFO - Bus: Built-In 04:48:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:27 INFO - Vendor: Intel (0x8086) 04:48:27 INFO - Device ID: 0x0a2e 04:48:27 INFO - Revision ID: 0x0009 04:48:27 INFO - Displays: 04:48:27 INFO - Display: 04:48:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:27 INFO - Display Serial Number: 1600x1200 60 04:48:27 INFO - Main Display: Yes 04:48:27 INFO - Mirror: Off 04:48:27 INFO - Online: Yes 04:48:27 INFO - Rotation: Supported 04:48:27 INFO - Return code: 0 04:48:27 INFO - Running post-action listener: _resource_record_post_action 04:48:27 INFO - [mozharness: 2016-10-13 11:48:27.751033Z] Finished run-tests step (success) 04:48:27 INFO - Running post-run listener: _resource_record_post_run 04:48:27 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 1560576; Write bytes: 665114112; Read time: 12; Write time: 1952 04:48:27 INFO - TinderboxPrint: CPU usage
54.3% 04:48:27 INFO - TinderboxPrint: I/O read bytes / time
1,560,576 / 12 04:48:27 INFO - TinderboxPrint: I/O write bytes / time
665,114,112 / 1,952 04:48:27 INFO - TinderboxPrint: CPU idle
2,206.3 (45.7%) 04:48:27 INFO - TinderboxPrint: CPU system
972.7 (20.2%) 04:48:27 INFO - TinderboxPrint: CPU user
1,646.8 (34.1%) 04:48:27 INFO - TinderboxPrint: Swap in / out
364,519,424 / 0 04:48:27 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358054400; Write bytes: 355776000; Read time: 27584; Write time: 749 04:48:27 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 724992; Write bytes: 298307584; Read time: 9; Write time: 1171 04:48:28 INFO - Running post-run listener: _upload_blobber_files 04:48:28 INFO - Blob upload gear active. 04:48:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:48:28 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 04:48:28 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'] 04:48:28 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 04:48:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:29 INFO - (blobuploader) - INFO - Done attempting. 04:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:30 INFO - (blobuploader) - INFO - Done attempting. 04:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:33 INFO - (blobuploader) - INFO - Done attempting. 04:48:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:33 INFO - Return code: 0 04:48:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17f533ed521f98ab209816998e9ca1ce896d5d61ebe0dc6b841f240772c27a59ef247559eb31cb4db7ad8ad349ffacb44170a8e10b2f7f384b19a102ff276e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0535f9b0d9c04ec22c835f768915df055dfffae3a97168bb7d126a6109143438e0dbaaf7a4723a4f5b2de8c8ce1ca8fecb0514a0a182edd188f1af5d51cecd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/033d1d6c5a740b25b92ef7b7b1fbd460a4f47069189104c2473635c28ab0278d16701fb348329ee2074fddeaddb6e1e4235fcf7cf419972fd8576b84f88c8635"} 04:48:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:33 INFO - Contents: 04:48:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17f533ed521f98ab209816998e9ca1ce896d5d61ebe0dc6b841f240772c27a59ef247559eb31cb4db7ad8ad349ffacb44170a8e10b2f7f384b19a102ff276e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0535f9b0d9c04ec22c835f768915df055dfffae3a97168bb7d126a6109143438e0dbaaf7a4723a4f5b2de8c8ce1ca8fecb0514a0a182edd188f1af5d51cecd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/033d1d6c5a740b25b92ef7b7b1fbd460a4f47069189104c2473635c28ab0278d16701fb348329ee2074fddeaddb6e1e4235fcf7cf419972fd8576b84f88c8635"} 04:48:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:33 INFO - Copying logs to upload dir... 04:48:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.839667 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-13 04:48:33.220116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:33.223614) ========= 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.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17f533ed521f98ab209816998e9ca1ce896d5d61ebe0dc6b841f240772c27a59ef247559eb31cb4db7ad8ad349ffacb44170a8e10b2f7f384b19a102ff276e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0535f9b0d9c04ec22c835f768915df055dfffae3a97168bb7d126a6109143438e0dbaaf7a4723a4f5b2de8c8ce1ca8fecb0514a0a182edd188f1af5d51cecd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/033d1d6c5a740b25b92ef7b7b1fbd460a4f47069189104c2473635c28ab0278d16701fb348329ee2074fddeaddb6e1e4235fcf7cf419972fd8576b84f88c8635"} build_url:https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010897 build_url: 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17f533ed521f98ab209816998e9ca1ce896d5d61ebe0dc6b841f240772c27a59ef247559eb31cb4db7ad8ad349ffacb44170a8e10b2f7f384b19a102ff276e73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0535f9b0d9c04ec22c835f768915df055dfffae3a97168bb7d126a6109143438e0dbaaf7a4723a4f5b2de8c8ce1ca8fecb0514a0a182edd188f1af5d51cecd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/033d1d6c5a740b25b92ef7b7b1fbd460a4f47069189104c2473635c28ab0278d16701fb348329ee2074fddeaddb6e1e4235fcf7cf419972fd8576b84f88c8635"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:33.257045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:33.257508) ========= 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.YRgEzUAPBH/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.drYIB25IXn/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.004950 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:33.307261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:48:33.307571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:48:33.307909) ========= ========= Total master_lag: 0.18 =========