builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0308 starttime: 1477975044.26 results: success (0) buildid: 20161031192504 builduid: 571b25a594b04242b8802b541649ef78 revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.261327) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.286087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.286765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.403027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.403406) ========= 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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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-31 21:37:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.73M=0.002s 2016-10-31 21:37:25 (7.73 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.743163 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:25.237039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:25.237409) ========= 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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.019424 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:25.278069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:25.278583) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9ce0a0617634b3d5d8fec265a394e4128df84c2 --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 d9ce0a0617634b3d5d8fec265a394e4128df84c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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-31 21:37:25,365 truncating revision to first 12 chars 2016-10-31 21:37:25,365 Setting DEBUG logging. 2016-10-31 21:37:25,365 attempt 1/10 2016-10-31 21:37:25,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9ce0a061763?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 21:37:26,061 unpacking tar archive at: mozilla-aurora-d9ce0a061763/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962637 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:26.266395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:26.269738) ========= script_repo_revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:26.270129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:26.270392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:26.288980) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-31 21:37:26.289368) ========= /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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:37:26 INFO - MultiFileLogger online at 20161031 21:37:26 in /builds/slave/test 21:37: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 21:37:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:37:26 INFO - {'append_to_log': False, 21:37:26 INFO - 'base_work_dir': '/builds/slave/test', 21:37:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:37:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:37:26 INFO - 'branch': 'Mozilla-Aurora', 21:37:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:37:26 INFO - 'config_files': ('talos/mac_config.py',), 21:37:26 INFO - 'default_actions': ('clobber', 21:37:26 INFO - 'read-buildbot-config', 21:37:26 INFO - 'download-and-extract', 21:37:26 INFO - 'populate-webroot', 21:37:26 INFO - 'create-virtualenv', 21:37:26 INFO - 'install', 21:37:26 INFO - 'run-tests'), 21:37:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:37:26 INFO - 'download_minidump_stackwalk': True, 21:37:26 INFO - 'download_symbols': 'ondemand', 21:37:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:37:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:37:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:37:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:37:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:37:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:37:26 INFO - 'installer_path': 'installer.exe', 21:37:26 INFO - 'log_level': 'info', 21:37:26 INFO - 'log_name': 'talos', 21:37:26 INFO - 'log_to_console': True, 21:37:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:37:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:37:26 INFO - 'opt_config_files': (), 21:37:26 INFO - 'pip_index': False, 21:37:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:26 INFO - 'cmd': ('bash', 21:37:26 INFO - '-c', 21:37:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:26 INFO - 'enabled': True, 21:37:26 INFO - 'halt_on_failure': False, 21:37:26 INFO - 'name': 'check_screen_resolution'},), 21:37:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:26 INFO - 'cmd': ('bash', 21:37:26 INFO - '-c', 21:37:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:26 INFO - 'enabled': True, 21:37:26 INFO - 'halt_on_failure': False, 21:37:26 INFO - 'name': 'check_screen_resolution'},), 21:37:26 INFO - 'run_cmd_checks_enabled': True, 21:37:26 INFO - 'sps_profile': False, 21:37:26 INFO - 'sps_profile_interval': 0, 21:37:26 INFO - 'suite': 'dromaeojs-e10s', 21:37:26 INFO - 'system_bits': '32', 21:37:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:37:26 INFO - 'title': 't-yosemite-r7-0308', 21:37:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:37:26 INFO - 'use_talos_json': True, 21:37:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:37:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:37:26 INFO - 'work_dir': 'build'} 21:37:26 INFO - [mozharness: 2016-11-01 04:37:26.497146Z] Running clobber step. 21:37:26 INFO - Running pre-action listener: _resource_record_pre_action 21:37:26 INFO - Running main action method: clobber 21:37:26 INFO - rmtree: /builds/slave/test/build 21:37:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:37:28 INFO - Running post-action listener: _resource_record_post_action 21:37:28 INFO - [mozharness: 2016-11-01 04:37:28.049733Z] Finished clobber step (success) 21:37:28 INFO - [mozharness: 2016-11-01 04:37:28.049873Z] Running read-buildbot-config step. 21:37:28 INFO - Running pre-action listener: _resource_record_pre_action 21:37:28 INFO - Running main action method: read_buildbot_config 21:37:28 INFO - Using buildbot properties: 21:37:28 INFO - { 21:37:28 INFO - "project": "", 21:37:28 INFO - "product": "firefox", 21:37:28 INFO - "script_repo_revision": "production", 21:37:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 21:37:28 INFO - "repository": "", 21:37:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 21:37:28 INFO - "buildid": "20161031192504", 21:37:28 INFO - "pgo_build": "False", 21:37:28 INFO - "basedir": "/builds/slave/test", 21:37:28 INFO - "buildnumber": 146, 21:37:28 INFO - "slavename": "t-yosemite-r7-0308", 21:37:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:37:28 INFO - "platform": "yosemite_r7", 21:37:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:37:28 INFO - "branch": "mozilla-aurora", 21:37:28 INFO - "repo_path": "releases/mozilla-aurora", 21:37:28 INFO - "revision": "d9ce0a0617634b3d5d8fec265a394e4128df84c2", 21:37:28 INFO - "stage_platform": "macosx64", 21:37:28 INFO - "builduid": "571b25a594b04242b8802b541649ef78", 21:37:28 INFO - "slavebuilddir": "test" 21:37:28 INFO - } 21:37:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:37:28 INFO - Running post-action listener: _resource_record_post_action 21:37:28 INFO - [mozharness: 2016-11-01 04:37:28.053298Z] Finished read-buildbot-config step (success) 21:37:28 INFO - [mozharness: 2016-11-01 04:37:28.053391Z] Running download-and-extract step. 21:37:28 INFO - Running pre-action listener: _resource_record_pre_action 21:37:28 INFO - Running main action method: download_and_extract 21:37:28 INFO - mkdir: /builds/slave/test/build/tests 21:37: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')]} 21:37:28 INFO - trying https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/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 21:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/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 21:37:29 INFO - Downloaded 1199 bytes. 21:37:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:29 INFO - Using the following test package requirements: 21:37:29 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:29 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:37:29 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:37:29 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'jsshell-mac.zip'], 21:37:29 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:37:29 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:29 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:37:29 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:37:29 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:37:29 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:29 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:37:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:37:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:30 INFO - Expected file size: 16421563 21:37: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 21:37:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:37 INFO - Expected file size: 16421563 21:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:37:44 INFO - Expected file size: 14414089 21:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:45 INFO - trying https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/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 21:37:49 INFO - Downloaded 115422385 bytes. 21:37:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:49 INFO - mkdir: /builds/slave/test/properties 21:37:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:37:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:37:49 INFO - Contents: 21:37:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:49 INFO - Running post-action listener: _resource_record_post_action 21:37:49 INFO - Running post-action listener: set_extra_try_arguments 21:37:49 INFO - [mozharness: 2016-11-01 04:37:49.962373Z] Finished download-and-extract step (success) 21:37:49 INFO - [mozharness: 2016-11-01 04:37:49.962496Z] Running populate-webroot step. 21:37:49 INFO - Running pre-action listener: _resource_record_pre_action 21:37:49 INFO - Running main action method: populate_webroot 21:37:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:37:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:37:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:37:49 INFO - '--tppagecycles', 21:37:49 INFO - '7'], 21:37:49 INFO - 'tests': ['tsvgm']}}, 21:37:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:37:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:37:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:37:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:37:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['damp', 'tps']}, 21:37:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'tests': ['damp', 'tps']}, 21:37:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['dromaeo_dom']}, 21:37:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:37:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['basic_compositor_video']}, 21:37:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:37:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['a11yr', 21:37:49 INFO - 'ts_paint', 21:37:49 INFO - 'tpaint', 21:37:49 INFO - 'sessionrestore', 21:37:49 INFO - 'sessionrestore_no_auto_restore', 21:37:49 INFO - 'tabpaint']}, 21:37:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['tsvgx', 21:37:49 INFO - 'tsvgr_opacity', 21:37:49 INFO - 'tart', 21:37:49 INFO - 'tscrollx', 21:37:49 INFO - 'cart']}, 21:37:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:37:49 INFO - 'tsvgr_opacity', 21:37:49 INFO - 'tart', 21:37:49 INFO - 'tscrollx', 21:37:49 INFO - 'cart']}, 21:37:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'talos_options': ['--disable-e10s'], 21:37:49 INFO - 'tests': ['tp5o']}, 21:37:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'tests': ['tp5o']}, 21:37:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'talos_options': ['--disable-e10s', 21:37:49 INFO - '--xperf_path', 21:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:49 INFO - 'tests': ['tp5n']}, 21:37:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:49 INFO - 'talos_options': ['--xperf_path', 21:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:49 INFO - 'tests': ['tp5n']}}, 21:37:49 INFO - 'talos.zip': {'path': '', 21:37:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:37:49 INFO - Running post-action listener: _resource_record_post_action 21:37:49 INFO - [mozharness: 2016-11-01 04:37:49.981898Z] Finished populate-webroot step (success) 21:37:49 INFO - [mozharness: 2016-11-01 04:37:49.982035Z] Running create-virtualenv step. 21:37:49 INFO - Running pre-action listener: _resource_record_pre_action 21:37:49 INFO - Running main action method: create_virtualenv 21:37:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:37:49 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 21:37:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:37:50 INFO - Using real prefix '/tools/python27' 21:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:37:53 INFO - Installing pip.................done. 21:37:53 INFO - Return code: 0 21:37:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:53 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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:37:53 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 21:37:53 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 21:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:53 INFO - 'HOME': '/Users/cltbld', 21:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:53 INFO - 'LOGNAME': 'cltbld', 21:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:53 INFO - 'MOZ_NO_REMOTE': '1', 21:37:53 INFO - 'NO_EM_RESTART': '1', 21:37:53 INFO - 'PAGER': '/bin/cat', 21:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:53 INFO - 'PWD': '/builds/slave/test', 21:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:53 INFO - 'SHELL': '/bin/bash', 21:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:37:53 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:53 INFO - 'USER': 'cltbld', 21:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:53 INFO - 'XPC_FLAGS': '0x0', 21:37:53 INFO - 'XPC_SERVICE_NAME': '0', 21:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:53 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 21:37:53 INFO - Cleaning up... 21:37:53 INFO - Return code: 0 21:37:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:53 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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:37:53 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 21:37:53 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 21:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:53 INFO - 'HOME': '/Users/cltbld', 21:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:53 INFO - 'LOGNAME': 'cltbld', 21:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:53 INFO - 'MOZ_NO_REMOTE': '1', 21:37:53 INFO - 'NO_EM_RESTART': '1', 21:37:53 INFO - 'PAGER': '/bin/cat', 21:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:53 INFO - 'PWD': '/builds/slave/test', 21:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:53 INFO - 'SHELL': '/bin/bash', 21:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:37:53 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:53 INFO - 'USER': 'cltbld', 21:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:53 INFO - 'XPC_FLAGS': '0x0', 21:37:53 INFO - 'XPC_SERVICE_NAME': '0', 21:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:54 INFO - Downloading/unpacking psutil>=3.1.1 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:57 INFO - Installing collected packages: psutil 21:37:57 INFO - Running setup.py install for psutil 21:37:57 INFO - building 'psutil._psutil_osx' extension 21:37: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 21:37: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 21:37: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 21:37: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 21:37:58 INFO - building 'psutil._psutil_posix' extension 21:37: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 21:37:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:37:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:37:58 INFO - ^ 21:37:58 INFO - 1 warning generated. 21:37: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 21:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:58 INFO - Successfully installed psutil 21:37:58 INFO - Cleaning up... 21:37:58 INFO - Return code: 0 21:37:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:37: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 21:37: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 21:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:58 INFO - 'HOME': '/Users/cltbld', 21:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:58 INFO - 'LOGNAME': 'cltbld', 21:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:58 INFO - 'MOZ_NO_REMOTE': '1', 21:37:58 INFO - 'NO_EM_RESTART': '1', 21:37:58 INFO - 'PAGER': '/bin/cat', 21:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:58 INFO - 'PWD': '/builds/slave/test', 21:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:58 INFO - 'SHELL': '/bin/bash', 21:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:37:58 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:58 INFO - 'USER': 'cltbld', 21:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:58 INFO - 'XPC_FLAGS': '0x0', 21:37:58 INFO - 'XPC_SERVICE_NAME': '0', 21:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:38:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:01 INFO - Installing collected packages: mozsystemmonitor 21:38:01 INFO - Running setup.py install for mozsystemmonitor 21:38:01 INFO - Successfully installed mozsystemmonitor 21:38:01 INFO - Cleaning up... 21:38:01 INFO - Return code: 0 21:38:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:01 INFO - 'HOME': '/Users/cltbld', 21:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:01 INFO - 'LOGNAME': 'cltbld', 21:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:01 INFO - 'MOZ_NO_REMOTE': '1', 21:38:01 INFO - 'NO_EM_RESTART': '1', 21:38:01 INFO - 'PAGER': '/bin/cat', 21:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:01 INFO - 'PWD': '/builds/slave/test', 21:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:01 INFO - 'SHELL': '/bin/bash', 21:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:01 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:01 INFO - 'USER': 'cltbld', 21:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:01 INFO - 'XPC_FLAGS': '0x0', 21:38:01 INFO - 'XPC_SERVICE_NAME': '0', 21:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:01 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:01 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 21:38:01 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 21:38:01 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 21:38:01 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 21:38:01 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 21:38:01 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 21:38:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:04 INFO - warning: no files found matching '*.txt' 21:38:04 INFO - no previously-included directories found matching 'build' 21:38:04 INFO - no previously-included directories found matching 'dist' 21:38:04 INFO - no previously-included directories found matching '.git*' 21:38:04 INFO - Installing collected packages: jsonschema, functools32 21:38:05 INFO - Running setup.py install for functools32 21:38:05 INFO - warning: no files found matching '*.txt' 21:38:05 INFO - no previously-included directories found matching 'build' 21:38:05 INFO - no previously-included directories found matching 'dist' 21:38:05 INFO - no previously-included directories found matching '.git*' 21:38:05 INFO - Successfully installed jsonschema functools32 21:38:05 INFO - Cleaning up... 21:38:05 INFO - Return code: 0 21:38:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:05 INFO - 'HOME': '/Users/cltbld', 21:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:05 INFO - 'LOGNAME': 'cltbld', 21:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:05 INFO - 'MOZ_NO_REMOTE': '1', 21:38:05 INFO - 'NO_EM_RESTART': '1', 21:38:05 INFO - 'PAGER': '/bin/cat', 21:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:05 INFO - 'PWD': '/builds/slave/test', 21:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:05 INFO - 'SHELL': '/bin/bash', 21:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:05 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:05 INFO - 'USER': 'cltbld', 21:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:05 INFO - 'XPC_FLAGS': '0x0', 21:38:05 INFO - 'XPC_SERVICE_NAME': '0', 21:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:05 INFO - Cleaning up... 21:38:05 INFO - Return code: 0 21:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:05 INFO - 'HOME': '/Users/cltbld', 21:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:05 INFO - 'LOGNAME': 'cltbld', 21:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:05 INFO - 'MOZ_NO_REMOTE': '1', 21:38:05 INFO - 'NO_EM_RESTART': '1', 21:38:05 INFO - 'PAGER': '/bin/cat', 21:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:05 INFO - 'PWD': '/builds/slave/test', 21:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:05 INFO - 'SHELL': '/bin/bash', 21:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:05 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:05 INFO - 'USER': 'cltbld', 21:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:05 INFO - 'XPC_FLAGS': '0x0', 21:38:05 INFO - 'XPC_SERVICE_NAME': '0', 21:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:09 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 21:38:09 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 21:38:09 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 21:38:09 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 21:38:09 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 21:38:09 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 21:38:09 INFO - Downloading docopt-0.6.1.tar.gz 21:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:09 INFO - Running setup.py install for blobuploader 21:38:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:09 INFO - Running setup.py install for requests 21:38:10 INFO - Running setup.py install for docopt 21:38:10 INFO - Successfully installed blobuploader requests docopt 21:38:10 INFO - Cleaning up... 21:38:10 INFO - Return code: 0 21:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:10 INFO - 'HOME': '/Users/cltbld', 21:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:10 INFO - 'LOGNAME': 'cltbld', 21:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:10 INFO - 'MOZ_NO_REMOTE': '1', 21:38:10 INFO - 'NO_EM_RESTART': '1', 21:38:10 INFO - 'PAGER': '/bin/cat', 21:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:10 INFO - 'PWD': '/builds/slave/test', 21:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:10 INFO - 'SHELL': '/bin/bash', 21:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:10 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:10 INFO - 'USER': 'cltbld', 21:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:10 INFO - 'XPC_FLAGS': '0x0', 21:38:10 INFO - 'XPC_SERVICE_NAME': '0', 21:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:10 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-25C_bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:10 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-1svgG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:10 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-zcNepR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:10 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-CMNGsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-2XMsJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-qoqO5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-84ZNDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-wgrezy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-jsmNes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-JwmND0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-2Ngszz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-2XGls6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:11 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-0YZOro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:12 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-xeX_5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:12 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Qvhr1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:12 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-_XfCN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:12 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-A8XTLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:12 INFO - Running setup.py install for manifestparser 21:38:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for mozcrash 21:38:12 INFO - Running setup.py install for mozdebug 21:38:12 INFO - Running setup.py install for mozdevice 21:38:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Running setup.py install for mozfile 21:38:13 INFO - Running setup.py install for mozhttpd 21:38:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Running setup.py install for mozinfo 21:38:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Running setup.py install for mozInstall 21:38:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Running setup.py install for mozleak 21:38:13 INFO - Running setup.py install for mozlog 21:38:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Running setup.py install for moznetwork 21:38:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Running setup.py install for mozprocess 21:38:14 INFO - Running setup.py install for mozprofile 21:38:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Running setup.py install for mozrunner 21:38:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Running setup.py install for mozscreenshot 21:38:14 INFO - Running setup.py install for moztest 21:38:14 INFO - Running setup.py install for mozversion 21:38:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:14 INFO - Cleaning up... 21:38:14 INFO - Return code: 0 21:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:14 INFO - 'HOME': '/Users/cltbld', 21:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:14 INFO - 'LOGNAME': 'cltbld', 21:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:14 INFO - 'MOZ_NO_REMOTE': '1', 21:38:14 INFO - 'NO_EM_RESTART': '1', 21:38:14 INFO - 'PAGER': '/bin/cat', 21:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:14 INFO - 'PWD': '/builds/slave/test', 21:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:14 INFO - 'SHELL': '/bin/bash', 21:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:14 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:14 INFO - 'USER': 'cltbld', 21:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:14 INFO - 'XPC_FLAGS': '0x0', 21:38:14 INFO - 'XPC_SERVICE_NAME': '0', 21:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-exw2eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-3t2rej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Jv6QMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-FYf5S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-r56GvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-37OQg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-t8fDsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38: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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:15 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-z71plE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Fqoso7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-NYdS8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-0PSzKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-v7AXCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-upITVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Xauy6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-TU_hO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-1VGQnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38: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)) 21:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:16 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Nzi8UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:19 INFO - Downloading blessings-1.6.tar.gz 21:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:19 INFO - Installing collected packages: blessings 21:38:19 INFO - Running setup.py install for blessings 21:38:19 INFO - Successfully installed blessings 21:38:19 INFO - Cleaning up... 21:38:19 INFO - Return code: 0 21:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:20 INFO - Reading from file tmpfile_stdout 21:38:20 INFO - Current package versions: 21:38:20 INFO - blessings == 1.6 21:38:20 INFO - blobuploader == 1.2.4 21:38:20 INFO - docopt == 0.6.1 21:38:20 INFO - functools32 == 3.2.3-2 21:38:20 INFO - jsonschema == 2.5.1 21:38:20 INFO - manifestparser == 1.1 21:38:20 INFO - mozInstall == 1.12 21:38:20 INFO - mozcrash == 0.17 21:38:20 INFO - mozdebug == 0.1 21:38:20 INFO - mozdevice == 0.48 21:38:20 INFO - mozfile == 1.2 21:38:20 INFO - mozhttpd == 0.7 21:38:20 INFO - mozinfo == 0.9 21:38:20 INFO - mozleak == 0.1 21:38:20 INFO - mozlog == 3.4 21:38:20 INFO - moznetwork == 0.27 21:38:20 INFO - mozprocess == 0.23 21:38:20 INFO - mozprofile == 0.28 21:38:20 INFO - mozrunner == 6.12 21:38:20 INFO - mozscreenshot == 0.1 21:38:20 INFO - mozsystemmonitor == 0.3 21:38:20 INFO - moztest == 0.7 21:38:20 INFO - mozversion == 1.4 21:38:20 INFO - psutil == 3.1.1 21:38:20 INFO - requests == 1.2.3 21:38:20 INFO - wsgiref == 0.1.2 21:38:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:20 INFO - 'HOME': '/Users/cltbld', 21:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:20 INFO - 'LOGNAME': 'cltbld', 21:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:20 INFO - 'MOZ_NO_REMOTE': '1', 21:38:20 INFO - 'NO_EM_RESTART': '1', 21:38:20 INFO - 'PAGER': '/bin/cat', 21:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:20 INFO - 'PWD': '/builds/slave/test', 21:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:20 INFO - 'SHELL': '/bin/bash', 21:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:20 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:20 INFO - 'USER': 'cltbld', 21:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:20 INFO - 'XPC_FLAGS': '0x0', 21:38:20 INFO - 'XPC_SERVICE_NAME': '0', 21:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38: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)) 21:38:20 INFO - Cleaning up... 21:38:20 INFO - Return code: 0 21:38:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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 0x11018f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110105570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dac90090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, '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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 21:38: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 21:38: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 21:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:20 INFO - 'HOME': '/Users/cltbld', 21:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:20 INFO - 'LOGNAME': 'cltbld', 21:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:20 INFO - 'MOZ_NO_REMOTE': '1', 21:38:20 INFO - 'NO_EM_RESTART': '1', 21:38:20 INFO - 'PAGER': '/bin/cat', 21:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:20 INFO - 'PWD': '/builds/slave/test', 21:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:20 INFO - 'SHELL': '/bin/bash', 21:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:20 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:20 INFO - 'USER': 'cltbld', 21:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:20 INFO - 'XPC_FLAGS': '0x0', 21:38:20 INFO - 'XPC_SERVICE_NAME': '0', 21:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:20 INFO - Cleaning up... 21:38:20 INFO - Return code: 0 21:38:20 INFO - Running post-action listener: _resource_record_post_action 21:38:20 INFO - Running post-action listener: _start_resource_monitoring 21:38:20 INFO - Starting resource monitoring. 21:38:20 INFO - [mozharness: 2016-11-01 04:38:20.789987Z] Finished create-virtualenv step (success) 21:38:20 INFO - [mozharness: 2016-11-01 04:38:20.790966Z] Running install step. 21:38:20 INFO - Running pre-action listener: _resource_record_pre_action 21:38:20 INFO - Running main action method: install 21:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:21 INFO - Reading from file tmpfile_stdout 21:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:21 INFO - Reading from file tmpfile_stdout 21:38:21 INFO - Output received: 21:38:21 INFO - Usage: mozinstall [options] installer 21:38:21 INFO - Options: 21:38:21 INFO - -h, --help show this help message and exit 21:38:21 INFO - -d DEST, --destination=DEST 21:38:21 INFO - Directory to install application into. [default: 21:38:21 INFO - "/builds/slave/test"] 21:38:21 INFO - --app=APP Application being installed. [default: firefox] 21:38:21 INFO - mkdir: /builds/slave/test/build/application 21:38: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'] 21:38: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 21:38:53 INFO - Reading from file tmpfile_stdout 21:38:53 INFO - Output received: 21:38:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:38:53 INFO - Running post-action listener: _resource_record_post_action 21:38:53 INFO - [mozharness: 2016-11-01 04:38:53.363585Z] Finished install step (success) 21:38:53 INFO - [mozharness: 2016-11-01 04:38:53.363725Z] Running run-tests step. 21:38:53 INFO - Running pre-action listener: _resource_record_pre_action 21:38:53 INFO - Running main action method: run_tests 21:38:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:38:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:38:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:38:53 INFO - 2016-10-31 21:38:53.378 screenresolution[1950:21110] starting screenresolution argv=screenresolution get 21:38:53 INFO - 2016-10-31 21:38:53.381 screenresolution[1950:21110] Display 0: 1600x1200x32@60 21:38:53 INFO - 2016-10-31 21:38:53.387 screenresolution[1951:21112] starting screenresolution argv=screenresolution list 21:38:53 INFO - Available Modes on Display 0 21:38:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:38:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:38:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:38:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:38:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:38:53 INFO - Intel Iris: 21:38:53 INFO - Chipset Model: Intel Iris 21:38:53 INFO - Type: GPU 21:38:53 INFO - Bus: Built-In 21:38:53 INFO - VRAM (Dynamic, Max): 1536 MB 21:38:53 INFO - Vendor: Intel (0x8086) 21:38:53 INFO - Device ID: 0x0a2e 21:38:53 INFO - Revision ID: 0x0009 21:38:53 INFO - Displays: 21:38:53 INFO - Display: 21:38:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:38:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:38:53 INFO - Display Serial Number: 1600x1200 60 21:38:53 INFO - Main Display: Yes 21:38:53 INFO - Mirror: Off 21:38:53 INFO - Online: Yes 21:38:53 INFO - Rotation: Supported 21:38:53 INFO - Return code: 0 21:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:38:53 INFO - Python 2.7.3 21:38:53 INFO - Return code: 0 21:38:53 INFO - grabbing minidump binary from tooltool 21:38: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')]} 21:38: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 0x10ffa3d30>, '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 0x10fe09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:38: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 21:38: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 21:38: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 21:38:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:38:53 INFO - Return code: 0 21:38:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:38:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:38:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:38:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:38:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:38: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/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 21:38: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/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0308 --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 21:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9SnY7rPp56/Render', 21:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:53 INFO - 'HOME': '/Users/cltbld', 21:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:53 INFO - 'LOGNAME': 'cltbld', 21:38:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:38:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:53 INFO - 'MOZ_NO_REMOTE': '1', 21:38:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:38:53 INFO - 'NO_EM_RESTART': '1', 21:38:53 INFO - 'PAGER': '/bin/cat', 21:38:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:53 INFO - 'PWD': '/builds/slave/test', 21:38:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:53 INFO - 'SHELL': '/bin/bash', 21:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SbZPr2Rhfw/Listeners', 21:38:53 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 21:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:53 INFO - 'USER': 'cltbld', 21:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:53 INFO - 'XPC_FLAGS': '0x0', 21:38:53 INFO - 'XPC_SERVICE_NAME': '0', 21:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38: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/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 21:38:53 INFO - mozversion application_buildid: 20161031192504 21:38:53 INFO - mozversion application_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 21:38:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:38:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:38:53 INFO - mozversion application_name: Firefox 21:38:53 INFO - mozversion application_remotingname: firefox-dev 21:38:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:53 INFO - mozversion application_vendor: Mozilla 21:38:53 INFO - mozversion application_version: 51.0a2 21:38:53 INFO - mozversion platform_buildid: 20161031192504 21:38:53 INFO - mozversion platform_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 21:38:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:53 INFO - mozversion platform_version: 51.0a2 21:38:53 INFO - using testdate: 1477975133 21:38:53 INFO - actual date: 1477975133 21:38:53 INFO - starting webserver on 'localhost:55557' 21:38:53 INFO - SUITE-START | Running 2 tests 21:38:53 INFO - TEST-START | dromaeo_css 21:38:53 INFO - operating with platform_type : mac_ 21:38:53 INFO - Initialising browser for dromaeo_css test... 21:38:53 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpfvmMOa/profile http://localhost:55557/getInfo.html) 21:38:56 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 21:38:56 INFO - PROCESS | 1961 | colorDepth:24 21:38:56 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 21:38:56 INFO - PROCESS | 1961 | __metrics 21:38:57 ERROR - PROCESS | 1961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:38:57 INFO - TEST-INFO | 1961: exit 0 21:38:57 INFO - Browser initialized. 21:38:57 INFO - Running cycle 1/1 for dromaeo_css test... 21:38:57 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpfvmMOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:09 INFO - PROCESS | 1964 | RSS: Main: 225345536 21:39:09 INFO - PROCESS | 1964 | 21:39:59 INFO - PROCESS | 1964 | 1477975199444 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] 21:42:11 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55557/tests/dromaeo/cssquery-ext.html) 21:42:12 INFO - PROCESS | 1964 | RSS: Main: 236998656 21:42:12 INFO - PROCESS | 1964 | 21:45:15 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-ext.html (next: http://localhost:55557/tests/dromaeo/cssquery-jquery.html) 21:45:15 INFO - PROCESS | 1964 | RSS: Main: 246657024 21:45:15 INFO - PROCESS | 1964 | 21:48:17 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55557/tests/dromaeo/cssquery-mootools.html) 21:48:18 INFO - PROCESS | 1964 | RSS: Main: 251437056 21:48:18 INFO - PROCESS | 1964 | 21:51:20 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55557/tests/dromaeo/cssquery-prototype.html) 21:51:20 INFO - PROCESS | 1964 | RSS: Main: 252289024 21:51:20 INFO - PROCESS | 1964 | 21:54:23 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55557/tests/dromaeo/cssquery-yui.html) 21:54:24 INFO - PROCESS | 1964 | RSS: Main: 256626688 21:54:24 INFO - PROCESS | 1964 | 21:57:26 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:55557/tests/dromaeo/cssquery-yui.html (next: http://localhost:55557/tests/dromaeo/cssquery-dojo.html) 21:57:27 INFO - PROCESS | 1964 | RSS: Main: 258609152 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | __start_tp_report 21:57:27 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 21:57:27 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 21:57:27 INFO - PROCESS | 1964 | |i|pagename|runs| 21:57:27 INFO - PROCESS | 1964 | |0;dojo.html;3345.8661653533877;3364.4448665970112;3393.9830300848494;3398.422268214404;3408.7613867029318;5699.316082070152;5732.5987180897355;5778.62438941469;5797.82606521804;5800.738966746496;4330.935035974463;4494.393256910316;5824.883502329951;5910.734016969236;5922.703864806753;5248.8425347239545;5313.628046036779;5314.888969785226;5343.973280133594;5354.250404943292;4321.935170972438;5341.798095428517;5390.056740070491;5391.649542779726;5431.809886653968;5227.921581176285;5230.372355317349;5353.116735738598;5367.436419175989;5396.43337449568;5250.054990101761;5259.289995850569;5320.920186197211;5350.625456218067;5395.757190926418;5219.8434046978655;5285.048691235576;5294.92057619136;5294.947050529484;5347.679139251619;5653.462921022497;5820.505257053155;5826.592138550303;5923.318818335861;5968.492678122365;6108.755649774003;6148.600340977822;6164.291106522763;6169.5064394848305;6217.502599792051;6183.7835675751585;6190.876182476371;6191.0713392990965;6206.689665516751;6209.068639704035;5509.118541033416;5889.528837692974;5919.112133180014;5935.050391937356;5942.494887934531;4793.448753393404;5463.945360546344;6166.475849552839;6224.692814509004;6233.096201050822;6164.47601953839;6175.59858609189;6190.597611155261;6193.504519638418;6226.1905952226825;6131.294901086343;6187.381261873867;6227.097070924781;6231.875362492725;6246.094316324107;6003.129546215774;6070.605410648293;6127.908081378783;6134.601250918765;6152.630842149485;6132.417420345149;6145.0782382642965;6154;6174.629522228681;6179.6910154493;4991.975040124777;4996.725180115056;5010.5240002199735;5025.547700706954;5026.170681837529;4357.716748411343;4386.188555117314;4399.868003959887;4497.955020449819;4501.842435514807;5808.593398462067;5864.501517371071;5883.441073098049;5950.107483877367;5970.9701451492465;6152.3540028297275;6181.011038233951;6192.969035154885;6195.070739389128;6209.2548894133;4780.49804770501;5771.85570360736;5843.2403787507355;5863.120531920246;5903.498202652737;5455.727213639302;5483.396826349099;5487.5884308677005;5496.340439147328;5513.58648101386;6340.302566717657;6351.2060992375955;6351.968240158954;6352.714127864349;6358.33237510064;6113.476306051762;6137.193127861533;6146.569740118328;6183.81448556544;6201.10084037821;6274.152989346379;6307.842303942438;6309.779157729457;6316.936830631818;6324.956382196886;5094.541491265803;6165.506759459322;6206.906896396648;6221.813345599639;6257.749690012349;6122.947104152957;6131.804871721949;6181.132226125759;6191.473724733448;6203.286622038343;5035.697858128524;5465.535429488538;5683.834813863231;6197.225346831646;6215.844603884758;6169.383061693795;6184.567080304336;6186.072089186658;6207.099970504342;6209.782657607143;5854.590178687451;5918;5968.373320801427;6033.42682445167;6068.029115341524;5039.84880453587;5471.316085489314;5794.449527294901;5998.970005149947;6220.346863579259;6035.849103772441;6044.123602077586;6059.3637668045985;6068.939310606837;6102.9694851525455 21:57:27 INFO - PROCESS | 1964 | |1;ext.html;449.89101863905466;501.50601657367497;504.71735827936334;507.9009593129341;514.7529185990725;39277.80361098197;41788.58211417885;41814.58185418145;41854.95362615936;41865.16269674612;41933.951651208736;42514;42546.7872660637;42552.57447425525;42649.14701705964;9889.011098890125;10055.245856560787;10066.798664026715;10072.345297555636;10085.747856303615;9839.311248212593;9946.353487023356;9960.153386962116;9967.900320996807;9974.650887218948;9958.402495850236;9984.101430871257;10007.799844003152;10010.499475026256;10017.39895606266;9845.852312215322;9923.057309555581;9924.007599240054;9978.800423991479;10000.59997600095;9850.458224797634;9918.652847150388;9932.006799320083;9941.254405919584;9954.552045157985;41425.1714965702;41673.583264167275;41681;41698.1660366791;41806.581934180875;3230.644629090798;3297.8021318720953;3412.675795799395;3502.0194345583277;3502.159481724393;29905.189620758483;31045.689543104505;31365.686343136735;31424.528632070538;31795.84102079498;3247.382997230542;3301.96698033019;3314.2211580278617;3318.6183588887347;3333.449980753197;516444;523458.382708084;524107;526484.3675781635;527648;33338.66661333404;58312.4168758307;58663;58926.11610825841;58999.705001474715;33870.49194262088;35141.12147196341;35666.10834729153;35711.64288357135;35863.4620480693;15037.624059398602;15147.924260378628;15194.620134496505;15232.771508427382;15258.855585830885;12787.360631968364;12930.224186548649;12988.960883129326;13020.869791302155;13040.282784446757;7635.503692259986;7760.456768026297;7793.103103753219;7840.843183136305;7847.960760196277;3247.5453436518906;3255;3258.902232933016;3272.7054565089256;3284.507323901434;927.3230541704459;946.3943076430952;950.95720692569;953.4946478366477;981.8576306435527;29846.40307193844;30839.8458007713;31344.37311253762;31920.680793191772;32659.020229393158;1002.1631937332263;1019.3679918450459;1020.3928662445833;1077.1436707817304;1091.7270682329417;13818.239996800072;14931.92534037323;15602;15699.843001569838;15790.526284211492;700691;720119;721785;723479;725551;56048.43951560514;56149.43850561524;56238.156427653616;56299.71850140723;56560;1365.528892532075;1378.5726424808342;1401.4254155796075;1412.6185929798896;1415;28404.289892752848;28875.133745987652;30013.69986300109;30052;30610.84694576513;49930.25104623361;50635.98728025345;50645;50705.49294507008;50876.745616271684;666472;667530;668045;668299;671428;25940.481190376464;26043.218703438928;26220.73779262183;26284.94860205647;26830.926762929263;44455.555444446436;46238.53761462343;46645.83385415392;47199;47329.526704733886;39182;39377.015574610865;40104;40395.59604404036;40645.78062658007;39333.80333098316;39470.60529394669;40084.39873401843;40723.38914916219;40770.592294076676;33018.17454563655;36353.636463635026;38135.42796857994;38482.61517384902;40098;27464.17607471779;33777.493337599466;35683.82158089193;36044.63955360413;36245.81877090598;22554.436139096655;26364.077257295903;26376.340591485365;26385.604215936393;26511.734882651697 21:57:27 INFO - PROCESS | 1964 | |2;jquery.html;371.2426649634745;375.4762106860929;378.46258313195267;378.5230609432118;395.7862754112779;18929.432117036493;20615.38153855383;20899.68650470244;21310.36068917935;21524.569508609817;20208.69686954697;20323.288684896033;20517;20527.486812829688;20806.583868322625;6036.15493830864;6046.909296360536;6198.938010619904;6246.843828904291;6280.466160376373;4213.325867861143;6135.3864613538735;6206.193194884681;6207.472364848971;6228.439440450358;5134.306868572751;6796.25241223465;6852.760153394632;6902.516823822334;6909.516333856632;6809.148856392951;6885;6892.655367231669;6929.930700692979;6942.271061538541;5869.354371019184;5943.583949123563;6022.819315420545;6047.274327080779;6078.483328917047;25077;25423;25482.235532934043;25790.09734659278;26007.349816254555;2257.853239539441;2259.175400978631;2311.780380863815;2517.5720127578174;3166;14764.926175369163;15275.847241527665;15561.844381556266;15590.9220453897;16422.83577164237;1880.774307083145;1893.2237782509244;1931.3336898770042;1945.6303302372646;1965.2139144342234;124800.37599812033;126353;129814;129842;132477;11150.665480035612;11442.256253343507;11589.884101159048;11623.012043976187;11735.823962640567;14356.066855654559;14389.136651800925;14495.130292182503;14503;14513.274336283144;7106.964465177641;8285.047219569706;8503.74488765338;8508.276796472246;8611.78470538229;8463.873041904377;8536.530490822941;8543.145685431531;8639.870401943976;8686.826263474695;4383.276759334738;4420.58004489573;4459.977700111479;4553.954460455419;4650.95349046512;1908.7136929460692;1952.1313015708158;1971.960560788776;1997.7502812148482;3754.305453491113;820.6840366458837;826.7023871406288;848.4400295804862;867.4058270085012;959.7024922274118;16529.421470248482;18022.098895055195;18157.909210454127;20043.699344509845;21428.57142857134;860.5482121885934;889.301898010059;900.9369344145847;938.202527851321;940.2431043010442;9144.982524717168;10796.568137274578;10877.820638378633;10936.671899843017;11132.554697812158;660578;665329;672201;675316;675934;129206.35396822955;131985;132679;133279.3336033333;133795.6620433783;918.9356745027918;964.744342749172;971.300663522277;973.2311473935512;976.8192884316425;17652.470425887244;18331.358402456382;18848.057597119816;18858.811411885705;18985.71521427152;53008.73495632497;54620.72689636526;55533.88932221252;55556.72221638866;55947.44052559585;78786.21213787788;78800.60599696965;78894.2110578887;78902;80132;7219.350258476762;7436.144843343085;7454.664540095817;7524.473286869867;7729.768106956801;9710.805783884141;10648.414337211529;11987.700307492383;12914.966802655952;13038.804417933548;10325.277230593787;10905.291156075147;11151.219414641222;11209.495572699085;11290.209685321948;10681.145508359468;10763.085137763377;10779.299345542515;11034.393108379116;11139.387333696724;8349.081601024003;9497.857532136884;10616.256862019585;11112.444377780917;11616;8013.759587212393;8029.7189598363775;8129.430939834391;8223;8237.258646721824;7748.883766743391;10715.981981711724;10862.185336099983;11012.229143959847;11219.2146549744 21:57:27 INFO - PROCESS | 1964 | |3;mootools.html;1504.4659146003169;1525.3364786317952;1747.9038652874094;1854.7959724430302;1876.971845422319;8068.233517815798;8343.37424693149;8528.488290702562;9080.591373388197;9091.272698184146;8517.616707248173;8813.823723525526;8821.691240806573;8934.240589549896;8947.865782013276;2368.348704106367;2409.9759002410015;2413.3966508372905;2414.9637755433596;2422.2733180046002;2391.712994440661;2399.796017338528;2431.7081950166007;2435.7320694723567;2444.4133407982135;1953.1406181280263;2277.1574517428494;2391.0077317913046;2393.9521209575796;2424.35754525051;2324.244620498345;2374.0622454130607;2377.7741114594087;2382.201962342626;2390.940226494334;2352.800011998982;2377.8335516513853;2408.7952524035477;2409.8915548800346;2412.710474743042;8985.595648195847;9066.274698024143;9086.909130908738;9098.363114581982;9102.590383432695;5332.600054995891;5478.068728316156;5486.780528778844;5491.2312276281355;5492.340919089735;3621.2214373909737;3622.728295377831;3655.6161603031564;3681.5950245472977;3715.7398982071268;1081.9404932728696;1090.7545802194443;1091.5251865438559;1096.6381094238882;1097.286763603656;11794.646160615195;11826.994705450046;11870.347130907796;11896.881031189663;11958.40207989597;4608.815647374135;4739.123262196505;4845.5881250093435;4856.198727210041;4863.1003264395495;10092.596296148218;10187.388756674474;10193.439360835226;10200.642977495752;10204.43875586835;5356.035913535523;5432.674039557639;5435.972820135874;5437.809676661298;5457.836264912059;4411.20598292304;4562.634989200856;4699.788509517011;4822.9758851206225;4889.119958407449;4017.2568074906235;4050.594940505926;4110.7328023678965;4144.3990621359735;4169.749815011109;1314.921104733719;1324.9337533123305;1334.1128149780288;1334.6996925691835;1335.7729186038396;753.7135888362387;874.2612492443875;914.9039350868196;915.2037727177266;918.9448633082036;5734.885302293931;5986.2517185351835;6003.389729713612;6033.9742243818655;6041.426064523863;912.3476714149415;972.4797233480055;980.8970058143935;980.9607615695435;1008.0927165550917;3603.5135256740527;3837.9424308635394;3921.411788231731;4060.5127384714024;4083.060895993938;10603.628872989408;10706.839397409045;10885.292455990335;10929.180311476672;11005.504752286166;10188.592456301665;10849.132069434427;10915.345079295268;10927.180461465263;10933.890661093288;7058.611776352247;7603.581803000888;7832.921670783219;8182.631781569844;8403.537805420761;5016.874578135576;6024.728887199999;6079.544034197541;6105.419985101408;6166.352532984151;9953.751156221153;10012.749681258027;10014.749631259278;10181.236407269336;10250.05249002687;9025.007249202452;10246.333988290737;10261.17910567138;10353.9482302588;10429.739256518344;7110.644467776487;7318.34134927859;7470;7660.578668173304;7889.723859664884;8356.832863342577;8658.047614762498;8671.696490622799;8693.34799889998;8702.564871756513;7509.88735168962;7515.361194298327;7638.847223055619;7771.961140194489;7791.727289544839;7412.258774122544;7525.36034437079;7544.245575442412;7569.735059272899;7622.199669034671;5595.664260144405;5723.255976723;6180.443760061616;7136;7186.89219661695;4504.301833215857;4645.907081858276;4937.012597480447;4983.003399320078;5115.872103197301;4949.093048533632;4971.353724015855;4988.625853060962;5090.643654944267;5096.898062038813 21:57:27 INFO - PROCESS | 1964 | |4;prototype.html;292.3845305631647;300.36472859901306;307.6692555502835;308.97991630544027;312.3409605731905;5242.61461035229;5316.388615309241;5496.945030549693;5595.776168953242;5600.719964001799;4199.958000419995;4412.691111622188;4920.335754673118;5075.923861142086;5498.917516237259;4142.378643203513;4171.124063946575;4189.539150693421;4193.475815523059;4195.2029114468305;4201.159768046403;4203.369494575808;4226.809793559281;4232.470941132358;4238.131183107455;3856.3251430999603;4092.6725861931122;4112.650424713903;4148.564400737924;4165.812538435777;3594.5327107476123;4074.9592504075026;4099.319279095572;4109.938350924738;4121.1345617420375;3546.0425685065147;3548.806074532941;3551.520544726455;3558.501809746612;3565.964340356589;4720.740359280238;5053.317802096707;5325.547328477084;5383.81156659515;5417.485338892799;4639.37368455261;4668;4677.602403795681;4718.386609740746;4726.7400292983875;5057.595392368602;5754.136879468071;5757.88484230313;5790.71046447676;5824.446677565625;3470.6182319944787;3594.4069228577255;3718.7396882218254;3910.4525366448433;3917.4515567820526;5320.494553017457;5721.941440833459;5954.851128721816;6049.213602231725;6090.786822461193;3965.4448377227213;4071.185762847442;4073.7555746655294;4082.714210005271;4090.611391917763;4130.380442933584;4158.896027599334;4158.91682166355;4166.479190101238;4196.685248606367;4580.442649499187;4809.95190048102;4810.903781924342;4816.579109162805;4829.9034019319415;5061.392632884003;5106.387233532;5472.345912232564;5795.478406943395;5817.829283040753;1192.7554851255472;1406.4177799975027;1417.5251290817691;1420.6590418299534;1421.9857801421854;896.408370475483;900.5857305639479;904.3036861616519;963.8506031565119;981.9901800981899;5385.892282154413;5421.918671219935;5432.511074003359;5453.590980676465;5470.890582188334;5427.620066595379;5762.654240745569;5969.880602387928;5985.46130848217;5991.292481642711;5165.715885626251;5418.51233388989;5438.428964958702;5554.666719996813;5690.857728556736;2550.145701190122;2995.8465990593777;3093.8398100712234;3178;3195.472746996766;4875.975620121877;5068.898622027539;5474.753636086386;6240.875182496416;6360.459360954278;6091.994820854598;6092.329843717188;6122.663253521099;6136.815895523052;6172.654391331355;5332.173513105475;5768.903908257417;6255.437010669061;6257.498200431864;6269.811905642838;4604.815807367668;5067.746612669278;5944.821655350346;6017.87964240704;6114.296855861455;4545.704419268249;5054.91319366338;5648.322201335702;5732.7706891723865;5772.855678608068;4814.013127308964;5163.974180129076;5512.062949298549;5523.834284971457;6097.420745029215;3915.7258991870294;3917.9608203917596;3967.980160099181;3980.601939805996;3991.5210174779213;5498.405462415854;5978.910316345346;5992;5997.820065398045;6017.458428741435;5343.145096784496;5421.376541697755;5809.215755873072;5844.47399734026;5848.181254624271;4981.701097934136;5014.0974624567925;5782;5795.768169273182;5832.679202643895;5316.362036555638;5331.600129990189;5706.80026199081;5707.5433965281845;5720.570957178312;5187.118189907649;5314.893702125859;5818.4763371296785;5822.7670893163795;5832.825015249549;4683.531646835289;4736;5272.578193744568;5467.152591348347;5710.114932185352 21:57:27 INFO - PROCESS | 1964 | |5;yui.html;719.6653556096414;727.7089164334265;759.2597217712728;765.609539135041;792.065362871811;17280.135993200336;18067.72898406525;18074.909625451855;18083.819161808377;18126.3655772048;16219.351225950948;16220.675586488263;16341.019538827679;16345.754813677804;16395.67208655826;672.831792051987;698.6332175607796;814.4868732698421;835.2649668291909;863.0161615758041;834.9582520873962;843.4264700003995;860.9655613775442;863.7797361672765;864.1747131489412;895.1674942303655;899.2670973156856;903.1104362203224;910.9043550427209;913.4108500017485;898.9505577193252;900.5992333411667;900.7928176519405;901.3825529512305;902.4946030223097;657.6120089147425;658.8056523325582;662.2814246542507;662.6256165266657;663.7643636509066;16014.5996350091;16160.27278772458;16171.757423638537;16216.675666486723;16242.862999590034;11813.822792658117;14274.928625356806;14309.212993285366;14395.78406323906;14398.424063037466;11542.82685759706;11611.477483513263;11776.352300623463;11882.821757673642;12247.816282755766;3700.5744339400776;3758.285925674113;3852.248811481762;3896.80515974203;3934.9803250983564;130713.34643326818;131520;133319.7620726286;133671.33164334213;133763;10710.571577136827;10807.513661885234;10840.945795270973;10871.619493317696;10895.83656245157;22484.32547023592;22486;22591.548169036527;22592.887035565047;23036.53926921452;7653.540787552764;8068.394870384627;8093.231143041402;8151.30713889326;8155.184481551797;4472.731636101845;4506.752128632891;4617.953820461819;4620.19146649335;4726.740029298353;3655.3968595182027;3717.070732316921;3768.2086761779783;3786.053486628343;3787.7348585598743;587.2072701852464;595.4194660206351;595.5473839881721;602.7558838670345;663.9834004149839;479.1327696868679;500.85475212188055;526.8867193553405;590.6957916672917;667.4460198035619;9231.676891308905;9606.951965240129;9757.12185903272;9771;9798.902010979798;572.4962033410656;642.354433794034;644.9097126402307;656.2846497317851;663.8506336074441;4476.26141686618;4693.155232058194;4779.470569417753;4813.566778989908;4835.540623640749;166179;169459.52159614745;172349;176973;178901;96562;97042.02957970471;102800;140303;148508;72928.54142917218;75789;79143;90688.09311906928;114357;9450.905490945277;9580.904190958001;9622.230221582116;9744.415335079917;9790.951045244728;60778.696106519186;62958.05562916651;63083.36916630959;63423.99999999815;64813;79399.20600793918;97201;99028.00971990188;99681;102943.97056029344;12090.576829810914;12315.815262770886;12414.937925310316;12445.377731113227;12995.220286782824;14331.355089021228;14803.407863685332;14813.185274809988;14887.627809304853;15445.768313475532;13349.66625834362;13492.325383730578;13845.16928984264;14002.929985350009;14475.420983160977;13480.325983700579;13615.52345667897;13879.583612491642;13892.791608125684;14398;13184.01119915991;13512;13762.862371376157;14000.43998240059;14089.929550352183;11119.72200694989;11181.72045698864;11641.88358116408;11785.528578857093;11875.168738188244;9751;11178.944105279421;11557.439745634232;11604.6518604442;11778 21:57:27 INFO - PROCESS | 1964 | __end_tp_report 21:57:27 INFO - PROCESS | 1964 | __start_cc_report 21:57:27 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,360 21:57:27 INFO - PROCESS | 1964 | __end_cc_report 21:57:27 INFO - PROCESS | 1964 | __startTimestamp1477976247201__endTimestamp 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | ------- Summary: start ------- 21:57:27 INFO - PROCESS | 1964 | Number of tests: 6 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5714.20 Median:5942.49 stddev:649.01 (10.9%) stddev-sans-first:623.84 21:57:27 INFO - PROCESS | 1964 | Values: 3345.9 3364.4 3394.0 3398.4 3408.8 5699.3 5732.6 5778.6 5797.8 5800.7 4330.9 4494.4 5824.9 5910.7 5922.7 5248.8 5313.6 5314.9 5344.0 5354.3 4321.9 5341.8 5390.1 5391.6 5431.8 5227.9 5230.4 5353.1 5367.4 5396.4 5250.1 5259.3 5320.9 5350.6 5395.8 5219.8 5285.0 5294.9 5294.9 5347.7 5653.5 5820.5 5826.6 5923.3 5968.5 6108.8 6148.6 6164.3 6169.5 6217.5 6183.8 6190.9 6191.1 6206.7 6209.1 5509.1 5889.5 5919.1 5935.1 5942.5 4793.4 5463.9 6166.5 6224.7 6233.1 6164.5 6175.6 6190.6 6193.5 6226.2 6131.3 6187.4 6227.1 6231.9 6246.1 6003.1 6070.6 6127.9 6134.6 6152.6 6132.4 6145.1 6154.0 6174.6 6179.7 4992.0 4996.7 5010.5 5025.5 5026.2 4357.7 4386.2 4399.9 4498.0 4501.8 5808.6 5864.5 5883.4 5950.1 5971.0 6152.4 6181.0 6193.0 6195.1 6209.3 4780.5 5771.9 5843.2 5863.1 5903.5 5455.7 5483.4 5487.6 5496.3 5513.6 6340.3 6351.2 6352.0 6352.7 6358.3 6113.5 6137.2 6146.6 6183.8 6201.1 6274.2 6307.8 6309.8 6316.9 6325.0 5094.5 6165.5 6206.9 6221.8 6257.7 6122.9 6131.8 6181.1 6191.5 6203.3 5035.7 5465.5 5683.8 6197.2 6215.8 6169.4 6184.6 6186.1 6207.1 6209.8 5854.6 5918.0 5968.4 6033.4 6068.0 5039.8 5471.3 5794.4 5999.0 6220.3 6035.8 6044.1 6059.4 6068.9 6103.0 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:74654.15 Median:39355.41 stddev:172463.94 (438.2%) stddev-sans-first:172857.75 21:57:27 INFO - PROCESS | 1964 | Values: 449.9 501.5 504.7 507.9 514.8 39277.8 41788.6 41814.6 41855.0 41865.2 41934.0 42514.0 42546.8 42552.6 42649.1 9889.0 10055.2 10066.8 10072.3 10085.7 9839.3 9946.4 9960.2 9967.9 9974.7 9958.4 9984.1 10007.8 10010.5 10017.4 9845.9 9923.1 9924.0 9978.8 10000.6 9850.5 9918.7 9932.0 9941.3 9954.6 41425.2 41673.6 41681.0 41698.2 41806.6 3230.6 3297.8 3412.7 3502.0 3502.2 29905.2 31045.7 31365.7 31424.5 31795.8 3247.4 3302.0 3314.2 3318.6 3333.4 516444.0 523458.4 524107.0 526484.4 527648.0 33338.7 58312.4 58663.0 58926.1 58999.7 33870.5 35141.1 35666.1 35711.6 35863.5 15037.6 15147.9 15194.6 15232.8 15258.9 12787.4 12930.2 12989.0 13020.9 13040.3 7635.5 7760.5 7793.1 7840.8 7848.0 3247.5 3255.0 3258.9 3272.7 3284.5 927.3 946.4 951.0 953.5 981.9 29846.4 30839.8 31344.4 31920.7 32659.0 1002.2 1019.4 1020.4 1077.1 1091.7 13818.2 14931.9 15602.0 15699.8 15790.5 700691.0 720119.0 721785.0 723479.0 725551.0 56048.4 56149.4 56238.2 56299.7 56560.0 1365.5 1378.6 1401.4 1412.6 1415.0 28404.3 28875.1 30013.7 30052.0 30610.8 49930.3 50636.0 50645.0 50705.5 50876.7 666472.0 667530.0 668045.0 668299.0 671428.0 25940.5 26043.2 26220.7 26284.9 26830.9 44455.6 46238.5 46645.8 47199.0 47329.5 39182.0 39377.0 40104.0 40395.6 40645.8 39333.8 39470.6 40084.4 40723.4 40770.6 33018.2 36353.6 38135.4 38482.6 40098.0 27464.2 33777.5 35683.8 36044.6 36245.8 22554.4 26364.1 26376.3 26385.6 26511.7 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:37584.13 Median:2064.89 stddev:111517.26 (5400.6%) stddev-sans-first:111795.08 21:57:27 INFO - PROCESS | 1964 | Values: 371.2 375.5 378.5 378.5 395.8 18929.4 20615.4 20899.7 21310.4 21524.6 20208.7 20323.3 20517.0 20527.5 20806.6 6036.2 6046.9 6198.9 6246.8 6280.5 4213.3 6135.4 6206.2 6207.5 6228.4 5134.3 6796.3 6852.8 6902.5 6909.5 6809.1 6885.0 6892.7 6929.9 6942.3 5869.4 5943.6 6022.8 6047.3 6078.5 25077.0 25423.0 25482.2 25790.1 26007.3 2257.9 2259.2 2311.8 2517.6 3166.0 14764.9 15275.8 15561.8 15590.9 16422.8 1880.8 1893.2 1931.3 1945.6 1965.2 124800.4 126353.0 129814.0 129842.0 132477.0 11150.7 11442.3 11589.9 11623.0 11735.8 14356.1 14389.1 14495.1 14503.0 14513.3 7107.0 8285.0 8503.7 8508.3 8611.8 8463.9 8536.5 8543.1 8639.9 8686.8 4383.3 4420.6 4460.0 4554.0 4651.0 1908.7 1952.1 1972.0 1997.8 3754.3 820.7 826.7 848.4 867.4 959.7 16529.4 18022.1 18157.9 20043.7 21428.6 860.5 889.3 900.9 938.2 940.2 9145.0 10796.6 10877.8 10936.7 11132.6 660578.0 665329.0 672201.0 675316.0 675934.0 129206.4 131985.0 132679.0 133279.3 133795.7 918.9 964.7 971.3 973.2 976.8 17652.5 18331.4 18848.1 18858.8 18985.7 53008.7 54620.7 55533.9 55556.7 55947.4 78786.2 78800.6 78894.2 78902.0 80132.0 7219.4 7436.1 7454.7 7524.5 7729.8 9710.8 10648.4 11987.7 12915.0 13038.8 10325.3 10905.3 11151.2 11209.5 11290.2 10681.1 10763.1 10779.3 11034.4 11139.4 8349.1 9497.9 10616.3 11112.4 11616.0 8013.8 8029.7 8129.4 8223.0 8237.3 7748.9 10716.0 10862.2 11012.2 11219.2 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:5757.90 Median:4781.05 stddev:3231.15 (67.6%) stddev-sans-first:3224.40 21:57:27 INFO - PROCESS | 1964 | Values: 1504.5 1525.3 1747.9 1854.8 1877.0 8068.2 8343.4 8528.5 9080.6 9091.3 8517.6 8813.8 8821.7 8934.2 8947.9 2368.3 2410.0 2413.4 2415.0 2422.3 2391.7 2399.8 2431.7 2435.7 2444.4 1953.1 2277.2 2391.0 2394.0 2424.4 2324.2 2374.1 2377.8 2382.2 2390.9 2352.8 2377.8 2408.8 2409.9 2412.7 8985.6 9066.3 9086.9 9098.4 9102.6 5332.6 5478.1 5486.8 5491.2 5492.3 3621.2 3622.7 3655.6 3681.6 3715.7 1081.9 1090.8 1091.5 1096.6 1097.3 11794.6 11827.0 11870.3 11896.9 11958.4 4608.8 4739.1 4845.6 4856.2 4863.1 10092.6 10187.4 10193.4 10200.6 10204.4 5356.0 5432.7 5436.0 5437.8 5457.8 4411.2 4562.6 4699.8 4823.0 4889.1 4017.3 4050.6 4110.7 4144.4 4169.7 1314.9 1324.9 1334.1 1334.7 1335.8 753.7 874.3 914.9 915.2 918.9 5734.9 5986.3 6003.4 6034.0 6041.4 912.3 972.5 980.9 981.0 1008.1 3603.5 3837.9 3921.4 4060.5 4083.1 10603.6 10706.8 10885.3 10929.2 11005.5 10188.6 10849.1 10915.3 10927.2 10933.9 7058.6 7603.6 7832.9 8182.6 8403.5 5016.9 6024.7 6079.5 6105.4 6166.4 9953.8 10012.7 10014.7 10181.2 10250.1 9025.0 10246.3 10261.2 10353.9 10429.7 7110.6 7318.3 7470.0 7660.6 7889.7 8356.8 8658.0 8671.7 8693.3 8702.6 7509.9 7515.4 7638.8 7772.0 7791.7 7412.3 7525.4 7544.2 7569.7 7622.2 5595.7 5723.3 6180.4 7136.0 7186.9 4504.3 4645.9 4937.0 4983.0 5115.9 4949.1 4971.4 4988.6 5090.6 5096.9 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:4651.50 Median:5164.85 stddev:1415.22 (27.4%) stddev-sans-first:1380.85 21:57:27 INFO - PROCESS | 1964 | Values: 292.4 300.4 307.7 309.0 312.3 5242.6 5316.4 5496.9 5595.8 5600.7 4200.0 4412.7 4920.3 5075.9 5498.9 4142.4 4171.1 4189.5 4193.5 4195.2 4201.2 4203.4 4226.8 4232.5 4238.1 3856.3 4092.7 4112.7 4148.6 4165.8 3594.5 4075.0 4099.3 4109.9 4121.1 3546.0 3548.8 3551.5 3558.5 3566.0 4720.7 5053.3 5325.5 5383.8 5417.5 4639.4 4668.0 4677.6 4718.4 4726.7 5057.6 5754.1 5757.9 5790.7 5824.4 3470.6 3594.4 3718.7 3910.5 3917.5 5320.5 5721.9 5954.9 6049.2 6090.8 3965.4 4071.2 4073.8 4082.7 4090.6 4130.4 4158.9 4158.9 4166.5 4196.7 4580.4 4810.0 4810.9 4816.6 4829.9 5061.4 5106.4 5472.3 5795.5 5817.8 1192.8 1406.4 1417.5 1420.7 1422.0 896.4 900.6 904.3 963.9 982.0 5385.9 5421.9 5432.5 5453.6 5470.9 5427.6 5762.7 5969.9 5985.5 5991.3 5165.7 5418.5 5438.4 5554.7 5690.9 2550.1 2995.8 3093.8 3178.0 3195.5 4876.0 5068.9 5474.8 6240.9 6360.5 6092.0 6092.3 6122.7 6136.8 6172.7 5332.2 5768.9 6255.4 6257.5 6269.8 4604.8 5067.7 5944.8 6017.9 6114.3 4545.7 5054.9 5648.3 5732.8 5772.9 4814.0 5164.0 5512.1 5523.8 6097.4 3915.7 3918.0 3968.0 3980.6 3991.5 5498.4 5978.9 5992.0 5997.8 6017.5 5343.1 5421.4 5809.2 5844.5 5848.2 4981.7 5014.1 5782.0 5795.8 5832.7 5316.4 5331.6 5706.8 5707.5 5720.6 5187.1 5314.9 5818.5 5822.8 5832.8 4683.5 4736.0 5272.6 5467.2 5710.1 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:25538.47 Median:3819.99 stddev:41764.71 (1093.3%) stddev-sans-first:41840.30 21:57:27 INFO - PROCESS | 1964 | Values: 719.7 727.7 759.3 765.6 792.1 17280.1 18067.7 18074.9 18083.8 18126.4 16219.4 16220.7 16341.0 16345.8 16395.7 672.8 698.6 814.5 835.3 863.0 835.0 843.4 861.0 863.8 864.2 895.2 899.3 903.1 910.9 913.4 899.0 900.6 900.8 901.4 902.5 657.6 658.8 662.3 662.6 663.8 16014.6 16160.3 16171.8 16216.7 16242.9 11813.8 14274.9 14309.2 14395.8 14398.4 11542.8 11611.5 11776.4 11882.8 12247.8 3700.6 3758.3 3852.2 3896.8 3935.0 130713.3 131520.0 133319.8 133671.3 133763.0 10710.6 10807.5 10840.9 10871.6 10895.8 22484.3 22486.0 22591.5 22592.9 23036.5 7653.5 8068.4 8093.2 8151.3 8155.2 4472.7 4506.8 4618.0 4620.2 4726.7 3655.4 3717.1 3768.2 3786.1 3787.7 587.2 595.4 595.5 602.8 664.0 479.1 500.9 526.9 590.7 667.4 9231.7 9607.0 9757.1 9771.0 9798.9 572.5 642.4 644.9 656.3 663.9 4476.3 4693.2 4779.5 4813.6 4835.5 166179.0 169459.5 172349.0 176973.0 178901.0 96562.0 97042.0 102800.0 140303.0 148508.0 72928.5 75789.0 79143.0 90688.1 114357.0 9450.9 9580.9 9622.2 9744.4 9791.0 60778.7 62958.1 63083.4 63424.0 64813.0 79399.2 97201.0 99028.0 99681.0 102944.0 12090.6 12315.8 12414.9 12445.4 12995.2 14331.4 14803.4 14813.2 14887.6 15445.8 13349.7 13492.3 13845.2 14002.9 14475.4 13480.3 13615.5 13879.6 13892.8 14398.0 13184.0 13512.0 13762.9 14000.4 14089.9 11119.7 11181.7 11641.9 11785.5 11875.2 9751.0 11178.9 11557.4 11604.7 11778.0 21:57:27 INFO - PROCESS | 1964 | -------- Summary: end -------- 21:57:27 INFO - PROCESS | 1964 | 21:57:27 INFO - TEST-INFO | 1964: exit 0 21:57:27 INFO - TEST-OK | dromaeo_css | took 1113808ms 21:57:27 INFO - TEST-START | kraken 21:57:27 INFO - operating with platform_type : mac_ 21:57:27 INFO - Initialising browser for kraken test... 21:57:27 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmp780XN2/profile http://localhost:55557/getInfo.html) 21:57:30 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 21:57:30 INFO - PROCESS | 1970 | colorDepth:24 21:57:30 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 21:57:30 INFO - PROCESS | 1970 | __metrics 21:57:30 ERROR - PROCESS | 1970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:57:31 INFO - TEST-INFO | 1970: exit 0 21:57:31 INFO - Browser initialized. 21:57:31 INFO - Running cycle 1/1 for kraken test... 21:57:31 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmp780XN2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:43 INFO - PROCESS | 1972 | RSS: Main: 225546240 21:57:43 INFO - PROCESS | 1972 | 21:57:46 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55557/tests/kraken/driver.html?testName=audio-beat-detection) 21:57:47 INFO - PROCESS | 1972 | RSS: Main: 238084096 21:57:47 INFO - PROCESS | 1972 | 21:57:49 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55557/tests/kraken/driver.html?testName=audio-dft) 21:57:50 INFO - PROCESS | 1972 | RSS: Main: 246030336 21:57:50 INFO - PROCESS | 1972 | 21:57:53 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55557/tests/kraken/driver.html?testName=audio-fft) 21:57:54 INFO - PROCESS | 1972 | RSS: Main: 249516032 21:57:54 INFO - PROCESS | 1972 | 21:57:56 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55557/tests/kraken/driver.html?testName=audio-oscillator) 21:57:57 INFO - PROCESS | 1972 | RSS: Main: 250404864 21:57:57 INFO - PROCESS | 1972 | 21:57:59 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:57:59 INFO - PROCESS | 1972 | RSS: Main: 250961920 21:57:59 INFO - PROCESS | 1972 | 21:58:02 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55557/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:03 INFO - PROCESS | 1972 | RSS: Main: 251146240 21:58:03 INFO - PROCESS | 1972 | 21:58:06 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55557/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:07 INFO - PROCESS | 1972 | RSS: Main: 251179008 21:58:07 INFO - PROCESS | 1972 | 21:58:10 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55557/tests/kraken/driver.html?testName=json-parse-financial) 21:58:10 INFO - PROCESS | 1972 | RSS: Main: 251461632 21:58:10 INFO - PROCESS | 1972 | 21:58:12 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:13 INFO - PROCESS | 1972 | RSS: Main: 251125760 21:58:13 INFO - PROCESS | 1972 | 21:58:14 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:15 INFO - PROCESS | 1972 | RSS: Main: 251142144 21:58:15 INFO - PROCESS | 1972 | 21:58:17 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:18 INFO - PROCESS | 1972 | RSS: Main: 251162624 21:58:18 INFO - PROCESS | 1972 | 21:58:21 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:22 INFO - PROCESS | 1972 | RSS: Main: 251539456 21:58:22 INFO - PROCESS | 1972 | 21:58:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:25 INFO - PROCESS | 1972 | RSS: Main: 251265024 21:58:25 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:55557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55557/tests/kraken/driver.html?testName=ai-astar) 21:58:27 INFO - PROCESS | 1972 | RSS: Main: 253030400 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | __start_tp_report 21:58:27 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 21:58:27 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 21:58:27 INFO - PROCESS | 1972 | |i|pagename|runs| 21:58:27 INFO - PROCESS | 1972 | |0;ai-astar;104;117;117;117;144;173;120;144;145;120 21:58:27 INFO - PROCESS | 1972 | |1;audio-beat-detection;139;109;110;143;110;113;112;110;134;110 21:58:27 INFO - PROCESS | 1972 | |2;audio-dft;197;200;197;198;197;200;195;225;277;203 21:58:27 INFO - PROCESS | 1972 | |3;audio-fft;79;57;70;82;65;84;86;85;65;84 21:58:27 INFO - PROCESS | 1972 | |4;audio-oscillator;82;63;121;87;68;74;104;57;63;79 21:58:27 INFO - PROCESS | 1972 | |5;imaging-gaussian-blur;89;108;135;92;91;75;135;133;88;86 21:58:27 INFO - PROCESS | 1972 | |6;imaging-darkroom;99;114;167;100;100;100;101;112;134;100 21:58:27 INFO - PROCESS | 1972 | |7;imaging-desaturate;97;146;108;90;91;90;138;147;98;89 21:58:27 INFO - PROCESS | 1972 | |8;json-parse-financial;57;56;56;58;60;74;93;92;85;58 21:58:27 INFO - PROCESS | 1972 | |9;json-stringify-tinderbox;70;91;69;76;119;65;60;92;63;72 21:58:27 INFO - PROCESS | 1972 | |10;stanford-crypto-aes;96;82;77;75;89;102;71;94;105;104 21:58:27 INFO - PROCESS | 1972 | |11;stanford-crypto-ccm;175;157;154;167;169;161;159;155;184;175 21:58:27 INFO - PROCESS | 1972 | |12;stanford-crypto-pbkdf2;162;166;162;161;158;164;165;156;151;167 21:58:27 INFO - PROCESS | 1972 | |13;stanford-crypto-sha256-iterative;69;66;68;68;68;65;68;66;67;66 21:58:27 INFO - PROCESS | 1972 | __end_tp_report 21:58:27 INFO - PROCESS | 1972 | __start_cc_report 21:58:27 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,954 21:58:27 INFO - PROCESS | 1972 | __end_cc_report 21:58:27 INFO - PROCESS | 1972 | __startTimestamp1477976307672__endTimestamp 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | ------- Summary: start ------- 21:58:27 INFO - PROCESS | 1972 | Number of tests: 14 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#0] ai-astar Cycles:10 Average:130.10 Median:132.00 stddev:20.68 (15.7%) stddev-sans-first:19.66 21:58:27 INFO - PROCESS | 1972 | Values: 104.0 117.0 117.0 117.0 144.0 173.0 120.0 144.0 145.0 120.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:112.50 stddev:13.78 (12.3%) stddev-sans-first:12.58 21:58:27 INFO - PROCESS | 1972 | Values: 139.0 109.0 110.0 143.0 110.0 113.0 112.0 110.0 134.0 110.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#2] audio-dft Cycles:10 Average:208.90 Median:200.00 stddev:25.44 (12.7%) stddev-sans-first:26.62 21:58:27 INFO - PROCESS | 1972 | Values: 197.0 200.0 197.0 198.0 197.0 200.0 195.0 225.0 277.0 203.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#3] audio-fft Cycles:10 Average:75.70 Median:83.00 stddev:10.50 (12.6%) stddev-sans-first:11.07 21:58:27 INFO - PROCESS | 1972 | Values: 79.0 57.0 70.0 82.0 65.0 84.0 86.0 85.0 65.0 84.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:71.00 stddev:19.99 (28.2%) stddev-sans-first:21.19 21:58:27 INFO - PROCESS | 1972 | Values: 82.0 63.0 121.0 87.0 68.0 74.0 104.0 57.0 63.0 79.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#5] imaging-gaussian-blur Cycles:10 Average:103.20 Median:87.00 stddev:22.93 (26.4%) stddev-sans-first:23.74 21:58:27 INFO - PROCESS | 1972 | Values: 89.0 108.0 135.0 92.0 91.0 75.0 135.0 133.0 88.0 86.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:113.00 stddev:22.05 (19.5%) stddev-sans-first:22.82 21:58:27 INFO - PROCESS | 1972 | Values: 99.0 114.0 167.0 100.0 100.0 100.0 101.0 112.0 134.0 100.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:90.00 stddev:24.41 (27.1%) stddev-sans-first:25.48 21:58:27 INFO - PROCESS | 1972 | Values: 97.0 146.0 108.0 90.0 91.0 90.0 138.0 147.0 98.0 89.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.00 stddev:15.60 (23.3%) stddev-sans-first:15.94 21:58:27 INFO - PROCESS | 1972 | Values: 57.0 56.0 56.0 58.0 60.0 74.0 93.0 92.0 85.0 58.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:71.00 stddev:18.10 (25.5%) stddev-sans-first:18.98 21:58:27 INFO - PROCESS | 1972 | Values: 70.0 91.0 69.0 76.0 119.0 65.0 60.0 92.0 63.0 72.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:79.50 stddev:12.62 (15.9%) stddev-sans-first:13.17 21:58:27 INFO - PROCESS | 1972 | Values: 96.0 82.0 77.0 75.0 89.0 102.0 71.0 94.0 105.0 104.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#11] stanford-crypto-ccm Cycles:10 Average:165.60 Median:168.00 stddev:10.08 (6.0%) stddev-sans-first:10.10 21:58:27 INFO - PROCESS | 1972 | Values: 175.0 157.0 154.0 167.0 169.0 161.0 159.0 155.0 184.0 175.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:163.00 stddev:4.96 (3.0%) stddev-sans-first:5.25 21:58:27 INFO - PROCESS | 1972 | Values: 162.0 166.0 162.0 161.0 158.0 164.0 165.0 156.0 151.0 167.0 21:58:27 INFO - PROCESS | 1972 | 21:58:27 INFO - PROCESS | 1972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 21:58:27 INFO - PROCESS | 1972 | Values: 69.0 66.0 68.0 68.0 68.0 65.0 68.0 66.0 67.0 66.0 21:58:27 INFO - PROCESS | 1972 | -------- Summary: end -------- 21:58:27 INFO - PROCESS | 1972 | 21:58:28 INFO - TEST-INFO | 1972: exit 0 21:58:28 INFO - TEST-OK | kraken | took 60816ms 21:58:28 INFO - SUITE-END | took 1174s 21:58:28 INFO - Completed test suite (00:19:34) 21:58:28 INFO - javascript benchmark 21:58:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.307393186345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.8661653533877, 3364.4448665970112, 3393.9830300848494, 3398.422268214404, 3408.7613867029318, 5699.316082070152, 5732.5987180897355, 5778.62438941469, 5797.82606521804, 5800.738966746496, 4330.935035974463, 4494.393256910316, 5824.883502329951, 5910.734016969236, 5922.703864806753, 5248.8425347239545, 5313.628046036779, 5314.888969785226, 5343.973280133594, 5354.250404943292, 4321.935170972438, 5341.798095428517, 5390.056740070491, 5391.649542779726, 5431.809886653968, 5227.921581176285, 5230.372355317349, 5353.116735738598, 5367.436419175989, 5396.43337449568, 5250.054990101761, 5259.289995850569, 5320.920186197211, 5350.625456218067, 5395.757190926418, 5219.8434046978655, 5285.048691235576, 5294.92057619136, 5294.947050529484, 5347.679139251619, 5653.462921022497, 5820.505257053155, 5826.592138550303, 5923.318818335861, 5968.492678122365, 6108.755649774003, 6148.600340977822, 6164.291106522763, 6169.5064394848305, 6217.502599792051, 6183.7835675751585, 6190.876182476371, 6191.0713392990965, 6206.689665516751, 6209.068639704035, 5509.118541033416, 5889.528837692974, 5919.112133180014, 5935.050391937356, 5942.494887934531, 4793.448753393404, 5463.945360546344, 6166.475849552839, 6224.692814509004, 6233.096201050822, 6164.47601953839, 6175.59858609189, 6190.597611155261, 6193.504519638418, 6226.1905952226825, 6131.294901086343, 6187.381261873867, 6227.097070924781, 6231.875362492725, 6246.094316324107, 6003.129546215774, 6070.605410648293, 6127.908081378783, 6134.601250918765, 6152.630842149485, 6132.417420345149, 6145.0782382642965, 6154.0, 6174.629522228681, 6179.6910154493, 4991.975040124777, 4996.725180115056, 5010.5240002199735, 5025.547700706954, 5026.170681837529, 4357.716748411343, 4386.188555117314, 4399.868003959887, 4497.955020449819, 4501.842435514807, 5808.593398462067, 5864.501517371071, 5883.441073098049, 5950.107483877367, 5970.9701451492465, 6152.3540028297275, 6181.011038233951, 6192.969035154885, 6195.070739389128, 6209.2548894133, 4780.49804770501, 5771.85570360736, 5843.2403787507355, 5863.120531920246, 5903.498202652737, 5455.727213639302, 5483.396826349099, 5487.5884308677005, 5496.340439147328, 5513.58648101386, 6340.302566717657, 6351.2060992375955, 6351.968240158954, 6352.714127864349, 6358.33237510064, 6113.476306051762, 6137.193127861533, 6146.569740118328, 6183.81448556544, 6201.10084037821, 6274.152989346379, 6307.842303942438, 6309.779157729457, 6316.936830631818, 6324.956382196886, 5094.541491265803, 6165.506759459322, 6206.906896396648, 6221.813345599639, 6257.749690012349, 6122.947104152957, 6131.804871721949, 6181.132226125759, 6191.473724733448, 6203.286622038343, 5035.697858128524, 5465.535429488538, 5683.834813863231, 6197.225346831646, 6215.844603884758, 6169.383061693795, 6184.567080304336, 6186.072089186658, 6207.099970504342, 6209.782657607143, 5854.590178687451, 5918.0, 5968.373320801427, 6033.42682445167, 6068.029115341524, 5039.84880453587, 5471.316085489314, 5794.449527294901, 5998.970005149947, 6220.346863579259, 6035.849103772441, 6044.123602077586, 6059.3637668045985, 6068.939310606837, 6102.9694851525455], "value": 5676.289024719353, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.89101863905466, 501.50601657367497, 504.71735827936334, 507.9009593129341, 514.7529185990725, 39277.80361098197, 41788.58211417885, 41814.58185418145, 41854.95362615936, 41865.16269674612, 41933.951651208736, 42514.0, 42546.7872660637, 42552.57447425525, 42649.14701705964, 9889.011098890125, 10055.245856560787, 10066.798664026715, 10072.345297555636, 10085.747856303615, 9839.311248212593, 9946.353487023356, 9960.153386962116, 9967.900320996807, 9974.650887218948, 9958.402495850236, 9984.101430871257, 10007.799844003152, 10010.499475026256, 10017.39895606266, 9845.852312215322, 9923.057309555581, 9924.007599240054, 9978.800423991479, 10000.59997600095, 9850.458224797634, 9918.652847150388, 9932.006799320083, 9941.254405919584, 9954.552045157985, 41425.1714965702, 41673.583264167275, 41681.0, 41698.1660366791, 41806.581934180875, 3230.644629090798, 3297.8021318720953, 3412.675795799395, 3502.0194345583277, 3502.159481724393, 29905.189620758483, 31045.689543104505, 31365.686343136735, 31424.528632070538, 31795.84102079498, 3247.382997230542, 3301.96698033019, 3314.2211580278617, 3318.6183588887347, 3333.449980753197, 516444.0, 523458.382708084, 524107.0, 526484.3675781635, 527648.0, 33338.66661333404, 58312.4168758307, 58663.0, 58926.11610825841, 58999.705001474715, 33870.49194262088, 35141.12147196341, 35666.10834729153, 35711.64288357135, 35863.4620480693, 15037.624059398602, 15147.924260378628, 15194.620134496505, 15232.771508427382, 15258.855585830885, 12787.360631968364, 12930.224186548649, 12988.960883129326, 13020.869791302155, 13040.282784446757, 7635.503692259986, 7760.456768026297, 7793.103103753219, 7840.843183136305, 7847.960760196277, 3247.5453436518906, 3255.0, 3258.902232933016, 3272.7054565089256, 3284.507323901434, 927.3230541704459, 946.3943076430952, 950.95720692569, 953.4946478366477, 981.8576306435527, 29846.40307193844, 30839.8458007713, 31344.37311253762, 31920.680793191772, 32659.020229393158, 1002.1631937332263, 1019.3679918450459, 1020.3928662445833, 1077.1436707817304, 1091.7270682329417, 13818.239996800072, 14931.92534037323, 15602.0, 15699.843001569838, 15790.526284211492, 700691.0, 720119.0, 721785.0, 723479.0, 725551.0, 56048.43951560514, 56149.43850561524, 56238.156427653616, 56299.71850140723, 56560.0, 1365.528892532075, 1378.5726424808342, 1401.4254155796075, 1412.6185929798896, 1415.0, 28404.289892752848, 28875.133745987652, 30013.69986300109, 30052.0, 30610.84694576513, 49930.25104623361, 50635.98728025345, 50645.0, 50705.49294507008, 50876.745616271684, 666472.0, 667530.0, 668045.0, 668299.0, 671428.0, 25940.481190376464, 26043.218703438928, 26220.73779262183, 26284.94860205647, 26830.926762929263, 44455.555444446436, 46238.53761462343, 46645.83385415392, 47199.0, 47329.526704733886, 39182.0, 39377.015574610865, 40104.0, 40395.59604404036, 40645.78062658007, 39333.80333098316, 39470.60529394669, 40084.39873401843, 40723.38914916219, 40770.592294076676, 33018.17454563655, 36353.636463635026, 38135.42796857994, 38482.61517384902, 40098.0, 27464.17607471779, 33777.493337599466, 35683.82158089193, 36044.63955360413, 36245.81877090598, 22554.436139096655, 26364.077257295903, 26376.340591485365, 26385.604215936393, 26511.734882651697], "value": 18972.13370337604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.2426649634745, 375.4762106860929, 378.46258313195267, 378.5230609432118, 395.7862754112779, 18929.432117036493, 20615.38153855383, 20899.68650470244, 21310.36068917935, 21524.569508609817, 20208.69686954697, 20323.288684896033, 20517.0, 20527.486812829688, 20806.583868322625, 6036.15493830864, 6046.909296360536, 6198.938010619904, 6246.843828904291, 6280.466160376373, 4213.325867861143, 6135.3864613538735, 6206.193194884681, 6207.472364848971, 6228.439440450358, 5134.306868572751, 6796.25241223465, 6852.760153394632, 6902.516823822334, 6909.516333856632, 6809.148856392951, 6885.0, 6892.655367231669, 6929.930700692979, 6942.271061538541, 5869.354371019184, 5943.583949123563, 6022.819315420545, 6047.274327080779, 6078.483328917047, 25077.0, 25423.0, 25482.235532934043, 25790.09734659278, 26007.349816254555, 2257.853239539441, 2259.175400978631, 2311.780380863815, 2517.5720127578174, 3166.0, 14764.926175369163, 15275.847241527665, 15561.844381556266, 15590.9220453897, 16422.83577164237, 1880.774307083145, 1893.2237782509244, 1931.3336898770042, 1945.6303302372646, 1965.2139144342234, 124800.37599812033, 126353.0, 129814.0, 129842.0, 132477.0, 11150.665480035612, 11442.256253343507, 11589.884101159048, 11623.012043976187, 11735.823962640567, 14356.066855654559, 14389.136651800925, 14495.130292182503, 14503.0, 14513.274336283144, 7106.964465177641, 8285.047219569706, 8503.74488765338, 8508.276796472246, 8611.78470538229, 8463.873041904377, 8536.530490822941, 8543.145685431531, 8639.870401943976, 8686.826263474695, 4383.276759334738, 4420.58004489573, 4459.977700111479, 4553.954460455419, 4650.95349046512, 1908.7136929460692, 1952.1313015708158, 1971.960560788776, 1997.7502812148482, 3754.305453491113, 820.6840366458837, 826.7023871406288, 848.4400295804862, 867.4058270085012, 959.7024922274118, 16529.421470248482, 18022.098895055195, 18157.909210454127, 20043.699344509845, 21428.57142857134, 860.5482121885934, 889.301898010059, 900.9369344145847, 938.202527851321, 940.2431043010442, 9144.982524717168, 10796.568137274578, 10877.820638378633, 10936.671899843017, 11132.554697812158, 660578.0, 665329.0, 672201.0, 675316.0, 675934.0, 129206.35396822955, 131985.0, 132679.0, 133279.3336033333, 133795.6620433783, 918.9356745027918, 964.744342749172, 971.300663522277, 973.2311473935512, 976.8192884316425, 17652.470425887244, 18331.358402456382, 18848.057597119816, 18858.811411885705, 18985.71521427152, 53008.73495632497, 54620.72689636526, 55533.88932221252, 55556.72221638866, 55947.44052559585, 78786.21213787788, 78800.60599696965, 78894.2110578887, 78902.0, 80132.0, 7219.350258476762, 7436.144843343085, 7454.664540095817, 7524.473286869867, 7729.768106956801, 9710.805783884141, 10648.414337211529, 11987.700307492383, 12914.966802655952, 13038.804417933548, 10325.277230593787, 10905.291156075147, 11151.219414641222, 11209.495572699085, 11290.209685321948, 10681.145508359468, 10763.085137763377, 10779.299345542515, 11034.393108379116, 11139.387333696724, 8349.081601024003, 9497.857532136884, 10616.256862019585, 11112.444377780917, 11616.0, 8013.759587212393, 8029.7189598363775, 8129.430939834391, 8223.0, 8237.258646721824, 7748.883766743391, 10715.981981711724, 10862.185336099983, 11012.229143959847, 11219.2146549744], "value": 9777.134979812017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.4659146003169, 1525.3364786317952, 1747.9038652874094, 1854.7959724430302, 1876.971845422319, 8068.233517815798, 8343.37424693149, 8528.488290702562, 9080.591373388197, 9091.272698184146, 8517.616707248173, 8813.823723525526, 8821.691240806573, 8934.240589549896, 8947.865782013276, 2368.348704106367, 2409.9759002410015, 2413.3966508372905, 2414.9637755433596, 2422.2733180046002, 2391.712994440661, 2399.796017338528, 2431.7081950166007, 2435.7320694723567, 2444.4133407982135, 1953.1406181280263, 2277.1574517428494, 2391.0077317913046, 2393.9521209575796, 2424.35754525051, 2324.244620498345, 2374.0622454130607, 2377.7741114594087, 2382.201962342626, 2390.940226494334, 2352.800011998982, 2377.8335516513853, 2408.7952524035477, 2409.8915548800346, 2412.710474743042, 8985.595648195847, 9066.274698024143, 9086.909130908738, 9098.363114581982, 9102.590383432695, 5332.600054995891, 5478.068728316156, 5486.780528778844, 5491.2312276281355, 5492.340919089735, 3621.2214373909737, 3622.728295377831, 3655.6161603031564, 3681.5950245472977, 3715.7398982071268, 1081.9404932728696, 1090.7545802194443, 1091.5251865438559, 1096.6381094238882, 1097.286763603656, 11794.646160615195, 11826.994705450046, 11870.347130907796, 11896.881031189663, 11958.40207989597, 4608.815647374135, 4739.123262196505, 4845.5881250093435, 4856.198727210041, 4863.1003264395495, 10092.596296148218, 10187.388756674474, 10193.439360835226, 10200.642977495752, 10204.43875586835, 5356.035913535523, 5432.674039557639, 5435.972820135874, 5437.809676661298, 5457.836264912059, 4411.20598292304, 4562.634989200856, 4699.788509517011, 4822.9758851206225, 4889.119958407449, 4017.2568074906235, 4050.594940505926, 4110.7328023678965, 4144.3990621359735, 4169.749815011109, 1314.921104733719, 1324.9337533123305, 1334.1128149780288, 1334.6996925691835, 1335.7729186038396, 753.7135888362387, 874.2612492443875, 914.9039350868196, 915.2037727177266, 918.9448633082036, 5734.885302293931, 5986.2517185351835, 6003.389729713612, 6033.9742243818655, 6041.426064523863, 912.3476714149415, 972.4797233480055, 980.8970058143935, 980.9607615695435, 1008.0927165550917, 3603.5135256740527, 3837.9424308635394, 3921.411788231731, 4060.5127384714024, 4083.060895993938, 10603.628872989408, 10706.839397409045, 10885.292455990335, 10929.180311476672, 11005.504752286166, 10188.592456301665, 10849.132069434427, 10915.345079295268, 10927.180461465263, 10933.890661093288, 7058.611776352247, 7603.581803000888, 7832.921670783219, 8182.631781569844, 8403.537805420761, 5016.874578135576, 6024.728887199999, 6079.544034197541, 6105.419985101408, 6166.352532984151, 9953.751156221153, 10012.749681258027, 10014.749631259278, 10181.236407269336, 10250.05249002687, 9025.007249202452, 10246.333988290737, 10261.17910567138, 10353.9482302588, 10429.739256518344, 7110.644467776487, 7318.34134927859, 7470.0, 7660.578668173304, 7889.723859664884, 8356.832863342577, 8658.047614762498, 8671.696490622799, 8693.34799889998, 8702.564871756513, 7509.88735168962, 7515.361194298327, 7638.847223055619, 7771.961140194489, 7791.727289544839, 7412.258774122544, 7525.36034437079, 7544.245575442412, 7569.735059272899, 7622.199669034671, 5595.664260144405, 5723.255976723, 6180.443760061616, 7136.0, 7186.89219661695, 4504.301833215857, 4645.907081858276, 4937.012597480447, 4983.003399320078, 5115.872103197301, 4949.093048533632, 4971.353724015855, 4988.625853060962, 5090.643654944267, 5096.898062038813], "value": 4635.320748852651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.3845305631647, 300.36472859901306, 307.6692555502835, 308.97991630544027, 312.3409605731905, 5242.61461035229, 5316.388615309241, 5496.945030549693, 5595.776168953242, 5600.719964001799, 4199.958000419995, 4412.691111622188, 4920.335754673118, 5075.923861142086, 5498.917516237259, 4142.378643203513, 4171.124063946575, 4189.539150693421, 4193.475815523059, 4195.2029114468305, 4201.159768046403, 4203.369494575808, 4226.809793559281, 4232.470941132358, 4238.131183107455, 3856.3251430999603, 4092.6725861931122, 4112.650424713903, 4148.564400737924, 4165.812538435777, 3594.5327107476123, 4074.9592504075026, 4099.319279095572, 4109.938350924738, 4121.1345617420375, 3546.0425685065147, 3548.806074532941, 3551.520544726455, 3558.501809746612, 3565.964340356589, 4720.740359280238, 5053.317802096707, 5325.547328477084, 5383.81156659515, 5417.485338892799, 4639.37368455261, 4668.0, 4677.602403795681, 4718.386609740746, 4726.7400292983875, 5057.595392368602, 5754.136879468071, 5757.88484230313, 5790.71046447676, 5824.446677565625, 3470.6182319944787, 3594.4069228577255, 3718.7396882218254, 3910.4525366448433, 3917.4515567820526, 5320.494553017457, 5721.941440833459, 5954.851128721816, 6049.213602231725, 6090.786822461193, 3965.4448377227213, 4071.185762847442, 4073.7555746655294, 4082.714210005271, 4090.611391917763, 4130.380442933584, 4158.896027599334, 4158.91682166355, 4166.479190101238, 4196.685248606367, 4580.442649499187, 4809.95190048102, 4810.903781924342, 4816.579109162805, 4829.9034019319415, 5061.392632884003, 5106.387233532, 5472.345912232564, 5795.478406943395, 5817.829283040753, 1192.7554851255472, 1406.4177799975027, 1417.5251290817691, 1420.6590418299534, 1421.9857801421854, 896.408370475483, 900.5857305639479, 904.3036861616519, 963.8506031565119, 981.9901800981899, 5385.892282154413, 5421.918671219935, 5432.511074003359, 5453.590980676465, 5470.890582188334, 5427.620066595379, 5762.654240745569, 5969.880602387928, 5985.46130848217, 5991.292481642711, 5165.715885626251, 5418.51233388989, 5438.428964958702, 5554.666719996813, 5690.857728556736, 2550.145701190122, 2995.8465990593777, 3093.8398100712234, 3178.0, 3195.472746996766, 4875.975620121877, 5068.898622027539, 5474.753636086386, 6240.875182496416, 6360.459360954278, 6091.994820854598, 6092.329843717188, 6122.663253521099, 6136.815895523052, 6172.654391331355, 5332.173513105475, 5768.903908257417, 6255.437010669061, 6257.498200431864, 6269.811905642838, 4604.815807367668, 5067.746612669278, 5944.821655350346, 6017.87964240704, 6114.296855861455, 4545.704419268249, 5054.91319366338, 5648.322201335702, 5732.7706891723865, 5772.855678608068, 4814.013127308964, 5163.974180129076, 5512.062949298549, 5523.834284971457, 6097.420745029215, 3915.7258991870294, 3917.9608203917596, 3967.980160099181, 3980.601939805996, 3991.5210174779213, 5498.405462415854, 5978.910316345346, 5992.0, 5997.820065398045, 6017.458428741435, 5343.145096784496, 5421.376541697755, 5809.215755873072, 5844.47399734026, 5848.181254624271, 4981.701097934136, 5014.0974624567925, 5782.0, 5795.768169273182, 5832.679202643895, 5316.362036555638, 5331.600129990189, 5706.80026199081, 5707.5433965281845, 5720.570957178312, 5187.118189907649, 5314.893702125859, 5818.4763371296785, 5822.7670893163795, 5832.825015249549, 4683.531646835289, 4736.0, 5272.578193744568, 5467.152591348347, 5710.114932185352], "value": 4198.964342085823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.6653556096414, 727.7089164334265, 759.2597217712728, 765.609539135041, 792.065362871811, 17280.135993200336, 18067.72898406525, 18074.909625451855, 18083.819161808377, 18126.3655772048, 16219.351225950948, 16220.675586488263, 16341.019538827679, 16345.754813677804, 16395.67208655826, 672.831792051987, 698.6332175607796, 814.4868732698421, 835.2649668291909, 863.0161615758041, 834.9582520873962, 843.4264700003995, 860.9655613775442, 863.7797361672765, 864.1747131489412, 895.1674942303655, 899.2670973156856, 903.1104362203224, 910.9043550427209, 913.4108500017485, 898.9505577193252, 900.5992333411667, 900.7928176519405, 901.3825529512305, 902.4946030223097, 657.6120089147425, 658.8056523325582, 662.2814246542507, 662.6256165266657, 663.7643636509066, 16014.5996350091, 16160.27278772458, 16171.757423638537, 16216.675666486723, 16242.862999590034, 11813.822792658117, 14274.928625356806, 14309.212993285366, 14395.78406323906, 14398.424063037466, 11542.82685759706, 11611.477483513263, 11776.352300623463, 11882.821757673642, 12247.816282755766, 3700.5744339400776, 3758.285925674113, 3852.248811481762, 3896.80515974203, 3934.9803250983564, 130713.34643326818, 131520.0, 133319.7620726286, 133671.33164334213, 133763.0, 10710.571577136827, 10807.513661885234, 10840.945795270973, 10871.619493317696, 10895.83656245157, 22484.32547023592, 22486.0, 22591.548169036527, 22592.887035565047, 23036.53926921452, 7653.540787552764, 8068.394870384627, 8093.231143041402, 8151.30713889326, 8155.184481551797, 4472.731636101845, 4506.752128632891, 4617.953820461819, 4620.19146649335, 4726.740029298353, 3655.3968595182027, 3717.070732316921, 3768.2086761779783, 3786.053486628343, 3787.7348585598743, 587.2072701852464, 595.4194660206351, 595.5473839881721, 602.7558838670345, 663.9834004149839, 479.1327696868679, 500.85475212188055, 526.8867193553405, 590.6957916672917, 667.4460198035619, 9231.676891308905, 9606.951965240129, 9757.12185903272, 9771.0, 9798.902010979798, 572.4962033410656, 642.354433794034, 644.9097126402307, 656.2846497317851, 663.8506336074441, 4476.26141686618, 4693.155232058194, 4779.470569417753, 4813.566778989908, 4835.540623640749, 166179.0, 169459.52159614745, 172349.0, 176973.0, 178901.0, 96562.0, 97042.02957970471, 102800.0, 140303.0, 148508.0, 72928.54142917218, 75789.0, 79143.0, 90688.09311906928, 114357.0, 9450.905490945277, 9580.904190958001, 9622.230221582116, 9744.415335079917, 9790.951045244728, 60778.696106519186, 62958.05562916651, 63083.36916630959, 63423.99999999815, 64813.0, 79399.20600793918, 97201.0, 99028.00971990188, 99681.0, 102943.97056029344, 12090.576829810914, 12315.815262770886, 12414.937925310316, 12445.377731113227, 12995.220286782824, 14331.355089021228, 14803.407863685332, 14813.185274809988, 14887.627809304853, 15445.768313475532, 13349.66625834362, 13492.325383730578, 13845.16928984264, 14002.929985350009, 14475.420983160977, 13480.325983700579, 13615.52345667897, 13879.583612491642, 13892.791608125684, 14398.0, 13184.01119915991, 13512.0, 13762.862371376157, 14000.43998240059, 14089.929550352183, 11119.72200694989, 11181.72045698864, 11641.88358116408, 11785.528578857093, 11875.168738188244, 9751.0, 11178.944105279421, 11557.439745634232, 11604.6518604442, 11778.0], "value": 7916.883163865014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 117.0, 117.0, 144.0, 173.0, 120.0, 144.0, 145.0, 120.0], "value": 130.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 110.0, 143.0, 110.0, 113.0, 112.0, 110.0, 134.0, 110.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 197.0, 198.0, 197.0, 200.0, 195.0, 225.0, 277.0, 203.0], "value": 208.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 70.0, 82.0, 65.0, 84.0, 86.0, 85.0, 65.0, 84.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 63.0, 121.0, 87.0, 68.0, 74.0, 104.0, 57.0, 63.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 108.0, 135.0, 92.0, 91.0, 75.0, 135.0, 133.0, 88.0, 86.0], "value": 103.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 114.0, 167.0, 100.0, 100.0, 100.0, 101.0, 112.0, 134.0, 100.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 146.0, 108.0, 90.0, 91.0, 90.0, 138.0, 147.0, 98.0, 89.0], "value": 109.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 58.0, 60.0, 74.0, 93.0, 92.0, 85.0, 58.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 91.0, 69.0, 76.0, 119.0, 65.0, 60.0, 92.0, 63.0, 72.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 82.0, 77.0, 75.0, 89.0, 102.0, 71.0, 94.0, 105.0, 104.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 157.0, 154.0, 167.0, 169.0, 161.0, 159.0, 155.0, 184.0, 175.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 161.0, 158.0, 164.0, 165.0, 156.0, 151.0, 167.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 68.0, 68.0, 68.0, 65.0, 68.0, 66.0, 67.0, 66.0], "value": 67.1, "unit": "score"}]}]} 21:58:28 INFO - Return code: 0 21:58:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:28 ERROR - # TBPL SUCCESS # 21:58:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:58:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:58:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:58:29 INFO - 2016-10-31 21:58:29.014 screenresolution[1977:24002] starting screenresolution argv=screenresolution get 21:58:29 INFO - 2016-10-31 21:58:29.016 screenresolution[1977:24002] Display 0: 1600x1200x32@60 21:58:29 INFO - 2016-10-31 21:58:29.022 screenresolution[1978:24005] starting screenresolution argv=screenresolution list 21:58:29 INFO - Available Modes on Display 0 21:58:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:58:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:58:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:58:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:58:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:58:29 INFO - Intel Iris: 21:58:29 INFO - Chipset Model: Intel Iris 21:58:29 INFO - Type: GPU 21:58:29 INFO - Bus: Built-In 21:58:29 INFO - VRAM (Dynamic, Max): 1536 MB 21:58:29 INFO - Vendor: Intel (0x8086) 21:58:29 INFO - Device ID: 0x0a2e 21:58:29 INFO - Revision ID: 0x0009 21:58:29 INFO - Displays: 21:58:29 INFO - Display: 21:58:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:58:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:58:29 INFO - Display Serial Number: 1600x1200 60 21:58:29 INFO - Main Display: Yes 21:58:29 INFO - Mirror: Off 21:58:29 INFO - Online: Yes 21:58:29 INFO - Rotation: Supported 21:58:29 INFO - Return code: 0 21:58:29 INFO - Running post-action listener: _resource_record_post_action 21:58:29 INFO - [mozharness: 2016-11-01 04:58:29.258630Z] Finished run-tests step (success) 21:58:29 INFO - Running post-run listener: _resource_record_post_run 21:58:29 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1204224; Write bytes: 664847872; Read time: 7; Write time: 1916 21:58:29 INFO - TinderboxPrint: CPU usage
54.3% 21:58:29 INFO - TinderboxPrint: I/O read bytes / time
1,204,224 / 7 21:58:29 INFO - TinderboxPrint: I/O write bytes / time
664,847,872 / 1,916 21:58:29 INFO - TinderboxPrint: CPU idle
2,206.9 (45.7%) 21:58:29 INFO - TinderboxPrint: CPU system
978.9 (20.3%) 21:58:29 INFO - TinderboxPrint: CPU user
1,643.9 (34.0%) 21:58:29 INFO - TinderboxPrint: Swap in / out
364,343,296 / 0 21:58:29 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358377984; Write bytes: 357663232; Read time: 27575; Write time: 732 21:58:29 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 368640; Write bytes: 296195072; Read time: 5; Write time: 1147 21:58:29 INFO - Running post-run listener: _upload_blobber_files 21:58:29 INFO - Blob upload gear active. 21:58:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:29 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 21:58:29 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'] 21:58:29 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 21:58:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:31 INFO - (blobuploader) - INFO - Done attempting. 21:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:32 INFO - (blobuploader) - INFO - Done attempting. 21:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:34 INFO - (blobuploader) - INFO - Done attempting. 21:58:34 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:34 INFO - Return code: 0 21:58:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b062f0233534d9fba8229e40d0b248d243a2c4a39fba8057eb1832b1546fed136a932a224060e7c5e9d33636e1625d092e7350304d520eea80271aa10392c33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3348bd8fb833c9b085aa7544f60fc17e2f9a559a2ff48d33bc32801276cb78e5cd9a2038e3363103b8347d7f19e8621ca022b96b8aaedf6d6b650b7c1586802e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8399bf8bbe031a20c236081af254872cfaf185b43d9fed7938b8e61756a57e12602cc3abebbe6f2f6ce91c1d6ebd8856134a8570ea33e11a013fabd7bf96db2a"} 21:58:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:34 INFO - Contents: 21:58:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b062f0233534d9fba8229e40d0b248d243a2c4a39fba8057eb1832b1546fed136a932a224060e7c5e9d33636e1625d092e7350304d520eea80271aa10392c33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3348bd8fb833c9b085aa7544f60fc17e2f9a559a2ff48d33bc32801276cb78e5cd9a2038e3363103b8347d7f19e8621ca022b96b8aaedf6d6b650b7c1586802e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8399bf8bbe031a20c236081af254872cfaf185b43d9fed7938b8e61756a57e12602cc3abebbe6f2f6ce91c1d6ebd8856134a8570ea33e11a013fabd7bf96db2a"} 21:58:34 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:34 INFO - Copying logs to upload dir... 21:58:34 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.306295 ========= master_lag: 0.77 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-31 21:58:35.369122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-31 21:58:35.373093) ========= 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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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/3b062f0233534d9fba8229e40d0b248d243a2c4a39fba8057eb1832b1546fed136a932a224060e7c5e9d33636e1625d092e7350304d520eea80271aa10392c33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3348bd8fb833c9b085aa7544f60fc17e2f9a559a2ff48d33bc32801276cb78e5cd9a2038e3363103b8347d7f19e8621ca022b96b8aaedf6d6b650b7c1586802e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8399bf8bbe031a20c236081af254872cfaf185b43d9fed7938b8e61756a57e12602cc3abebbe6f2f6ce91c1d6ebd8856134a8570ea33e11a013fabd7bf96db2a"} build_url:https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011005 build_url: 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/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/3b062f0233534d9fba8229e40d0b248d243a2c4a39fba8057eb1832b1546fed136a932a224060e7c5e9d33636e1625d092e7350304d520eea80271aa10392c33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3348bd8fb833c9b085aa7544f60fc17e2f9a559a2ff48d33bc32801276cb78e5cd9a2038e3363103b8347d7f19e8621ca022b96b8aaedf6d6b650b7c1586802e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8399bf8bbe031a20c236081af254872cfaf185b43d9fed7938b8e61756a57e12602cc3abebbe6f2f6ce91c1d6ebd8856134a8570ea33e11a013fabd7bf96db2a"}' ========= master_lag: 1.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-31 21:58:36.490903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:36.491268) ========= 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.9SnY7rPp56/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.SbZPr2Rhfw/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.005160 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:36.535391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:58:36.537741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:58:36.538069) ========= ========= Total master_lag: 2.06 =========