builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1479118527.21 results: success (0) buildid: 20161114004005 builduid: 52ef4f46403c4f9d996936125515ac3e revision: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:27.214149) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:27.214605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:27.214890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:27.421735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:27.422148) ========= 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.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-11-14 02:15:27-- 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% 8.48M=0.001s 2016-11-14 02:15:28 (8.48 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.598974 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.046613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.046951) ========= 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.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.019264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.100507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.100831) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 263190e20543fc7f39c6d41c8fd31cedccdbffd8 --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 263190e20543fc7f39c6d41c8fd31cedccdbffd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-11-14 02:15:28,179 truncating revision to first 12 chars 2016-11-14 02:15:28,179 Setting DEBUG logging. 2016-11-14 02:15:28,179 attempt 1/10 2016-11-14 02:15:28,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/263190e20543?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 02:15:28,552 unpacking tar archive at: mozilla-aurora-263190e20543/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637288 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.763616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.763958) ========= script_repo_revision: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.764380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.764684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 02:15:28.783694) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-14 02:15:28.784093) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:15:28 INFO - MultiFileLogger online at 20161114 02:15:28 in /builds/slave/test 02:15:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:15:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:15:28 INFO - {'append_to_log': False, 02:15:28 INFO - 'base_work_dir': '/builds/slave/test', 02:15:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:15:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:15:28 INFO - 'branch': 'Mozilla-Aurora', 02:15:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:15:28 INFO - 'config_files': ('talos/mac_config.py',), 02:15:28 INFO - 'default_actions': ('clobber', 02:15:28 INFO - 'read-buildbot-config', 02:15:28 INFO - 'download-and-extract', 02:15:28 INFO - 'populate-webroot', 02:15:28 INFO - 'create-virtualenv', 02:15:28 INFO - 'install', 02:15:28 INFO - 'run-tests'), 02:15:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:15:28 INFO - 'download_minidump_stackwalk': True, 02:15:28 INFO - 'download_symbols': 'ondemand', 02:15:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:15:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:15:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:15:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:15:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:15:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:15:28 INFO - 'installer_path': 'installer.exe', 02:15:28 INFO - 'log_level': 'info', 02:15:28 INFO - 'log_name': 'talos', 02:15:28 INFO - 'log_to_console': True, 02:15:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:15:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:15:28 INFO - 'opt_config_files': (), 02:15:28 INFO - 'pip_index': False, 02:15:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:15:28 INFO - 'cmd': ('bash', 02:15:28 INFO - '-c', 02:15:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:15:28 INFO - 'enabled': True, 02:15:28 INFO - 'halt_on_failure': False, 02:15:28 INFO - 'name': 'check_screen_resolution'},), 02:15:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:15:28 INFO - 'cmd': ('bash', 02:15:28 INFO - '-c', 02:15:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:15:28 INFO - 'enabled': True, 02:15:28 INFO - 'halt_on_failure': False, 02:15:28 INFO - 'name': 'check_screen_resolution'},), 02:15:28 INFO - 'run_cmd_checks_enabled': True, 02:15:28 INFO - 'sps_profile': False, 02:15:28 INFO - 'sps_profile_interval': 0, 02:15:28 INFO - 'suite': 'dromaeojs', 02:15:28 INFO - 'system_bits': '32', 02:15:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:15:28 INFO - 'title': 't-yosemite-r7-0137', 02:15:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:15:28 INFO - 'use_talos_json': True, 02:15:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:15:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:15:28 INFO - 'work_dir': 'build'} 02:15:28 INFO - [mozharness: 2016-11-14 10:15:28.995920Z] Running clobber step. 02:15:28 INFO - Running pre-action listener: _resource_record_pre_action 02:15:28 INFO - Running main action method: clobber 02:15:28 INFO - rmtree: /builds/slave/test/build 02:15:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:15:30 INFO - Running post-action listener: _resource_record_post_action 02:15:30 INFO - [mozharness: 2016-11-14 10:15:30.679883Z] Finished clobber step (success) 02:15:30 INFO - [mozharness: 2016-11-14 10:15:30.680069Z] Running read-buildbot-config step. 02:15:30 INFO - Running pre-action listener: _resource_record_pre_action 02:15:30 INFO - Running main action method: read_buildbot_config 02:15:30 INFO - Using buildbot properties: 02:15:30 INFO - { 02:15:30 INFO - "project": "", 02:15:30 INFO - "product": "firefox", 02:15:30 INFO - "script_repo_revision": "production", 02:15:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:15:30 INFO - "repository": "", 02:15:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:15:30 INFO - "buildid": "20161114004005", 02:15:30 INFO - "stage_platform": "macosx64", 02:15:30 INFO - "basedir": "/builds/slave/test", 02:15:30 INFO - "nightly_build": "True", 02:15:30 INFO - "buildnumber": 125, 02:15:30 INFO - "slavename": "t-yosemite-r7-0137", 02:15:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:15:30 INFO - "platform": "yosemite_r7", 02:15:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:15:30 INFO - "branch": "mozilla-aurora", 02:15:30 INFO - "repo_path": "releases/mozilla-aurora", 02:15:30 INFO - "revision": "263190e20543fc7f39c6d41c8fd31cedccdbffd8", 02:15:30 INFO - "pgo_build": "False", 02:15:30 INFO - "builduid": "52ef4f46403c4f9d996936125515ac3e", 02:15:30 INFO - "slavebuilddir": "test" 02:15:30 INFO - } 02:15:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:15:30 INFO - Running post-action listener: _resource_record_post_action 02:15:30 INFO - [mozharness: 2016-11-14 10:15:30.683451Z] Finished read-buildbot-config step (success) 02:15:30 INFO - [mozharness: 2016-11-14 10:15:30.683586Z] Running download-and-extract step. 02:15:30 INFO - Running pre-action listener: _resource_record_pre_action 02:15:30 INFO - Running main action method: download_and_extract 02:15:30 INFO - mkdir: /builds/slave/test/build/tests 02:15:30 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')]} 02:15:30 INFO - trying https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:15:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/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 02:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/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 02:15:32 INFO - Downloaded 1199 bytes. 02:15:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:15:32 INFO - Using the following test package requirements: 02:15:32 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:15:32 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:15:32 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:15:32 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'jsshell-mac.zip'], 02:15:32 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:15:32 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:15:32 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:15:32 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:15:32 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:15:32 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:15:32 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:15:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:15:32 INFO - Expected file size: 16423876 02:15:39 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 02:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:15:40 INFO - Expected file size: 16423876 02:15:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:15:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:15:46 INFO - Fetch https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:15:48 INFO - Expected file size: 14414089 02:15:49 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')]} 02:15:49 INFO - trying https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:15:49 INFO - Downloading https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/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 02:15:52 INFO - Downloaded 115622422 bytes. 02:15:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:15:52 INFO - mkdir: /builds/slave/test/properties 02:15:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:15:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:15:52 INFO - Contents: 02:15:52 INFO - build_url:https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:15:53 INFO - Running post-action listener: _resource_record_post_action 02:15:53 INFO - Running post-action listener: set_extra_try_arguments 02:15:53 INFO - [mozharness: 2016-11-14 10:15:53.234204Z] Finished download-and-extract step (success) 02:15:53 INFO - [mozharness: 2016-11-14 10:15:53.234356Z] Running populate-webroot step. 02:15:53 INFO - Running pre-action listener: _resource_record_pre_action 02:15:53 INFO - Running main action method: populate_webroot 02:15:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:53 INFO - '--tppagecycles', 02:15:53 INFO - '7'], 02:15:53 INFO - 'tests': ['tsvgm']}}, 02:15:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:15:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:15:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['damp', 'tps']}, 02:15:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'tests': ['damp', 'tps']}, 02:15:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['dromaeo_dom']}, 02:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:15:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['basic_compositor_video']}, 02:15:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:15:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['a11yr', 02:15:53 INFO - 'ts_paint', 02:15:53 INFO - 'tpaint', 02:15:53 INFO - 'sessionrestore', 02:15:53 INFO - 'sessionrestore_no_auto_restore', 02:15:53 INFO - 'tabpaint']}, 02:15:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['tsvgx', 02:15:53 INFO - 'tsvgr_opacity', 02:15:53 INFO - 'tart', 02:15:53 INFO - 'tscrollx', 02:15:53 INFO - 'cart']}, 02:15:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:15:53 INFO - 'tsvgr_opacity', 02:15:53 INFO - 'tart', 02:15:53 INFO - 'tscrollx', 02:15:53 INFO - 'cart']}, 02:15:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'talos_options': ['--disable-e10s'], 02:15:53 INFO - 'tests': ['tp5o']}, 02:15:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'tests': ['tp5o']}, 02:15:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'talos_options': ['--disable-e10s', 02:15:53 INFO - '--xperf_path', 02:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:53 INFO - 'tests': ['tp5n']}, 02:15:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:53 INFO - 'talos_options': ['--xperf_path', 02:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:53 INFO - 'tests': ['tp5n']}}, 02:15:53 INFO - 'talos.zip': {'path': '', 02:15:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:53 INFO - Running post-action listener: _resource_record_post_action 02:15:53 INFO - [mozharness: 2016-11-14 10:15:53.253499Z] Finished populate-webroot step (success) 02:15:53 INFO - [mozharness: 2016-11-14 10:15:53.253608Z] Running create-virtualenv step. 02:15:53 INFO - Running pre-action listener: _resource_record_pre_action 02:15:53 INFO - Running main action method: create_virtualenv 02:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:15:53 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 02:15:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:53 INFO - Using real prefix '/tools/python27' 02:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:56 INFO - Installing pip.................done. 02:15:56 INFO - Return code: 0 02:15:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:56 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:15:56 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 02:15:56 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 02:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:56 INFO - 'HOME': '/Users/cltbld', 02:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:56 INFO - 'LOGNAME': 'cltbld', 02:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:56 INFO - 'MOZ_NO_REMOTE': '1', 02:15:56 INFO - 'NO_EM_RESTART': '1', 02:15:56 INFO - 'PAGER': '/bin/cat', 02:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:56 INFO - 'PWD': '/builds/slave/test', 02:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:56 INFO - 'SHELL': '/bin/bash', 02:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:15:56 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:56 INFO - 'USER': 'cltbld', 02:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:56 INFO - 'XPC_FLAGS': '0x0', 02:15:56 INFO - 'XPC_SERVICE_NAME': '0', 02:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:57 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 02:15:57 INFO - Cleaning up... 02:15:57 INFO - Return code: 0 02:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:15:57 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')]} 02:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:57 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')]} 02:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:57 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:15:57 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 02:15:57 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 02:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:57 INFO - 'HOME': '/Users/cltbld', 02:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:57 INFO - 'LOGNAME': 'cltbld', 02:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:57 INFO - 'MOZ_NO_REMOTE': '1', 02:15:57 INFO - 'NO_EM_RESTART': '1', 02:15:57 INFO - 'PAGER': '/bin/cat', 02:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:57 INFO - 'PWD': '/builds/slave/test', 02:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:57 INFO - 'SHELL': '/bin/bash', 02:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:15:57 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:57 INFO - 'USER': 'cltbld', 02:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:57 INFO - 'XPC_FLAGS': '0x0', 02:15:57 INFO - 'XPC_SERVICE_NAME': '0', 02:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:57 INFO - Downloading/unpacking psutil>=3.1.1 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:16:00 INFO - Installing collected packages: psutil 02:16:00 INFO - Running setup.py install for psutil 02:16:00 INFO - building 'psutil._psutil_osx' extension 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 INFO - building 'psutil._psutil_posix' extension 02:16:00 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 02:16:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:16:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:16:00 INFO - ^ 02:16:00 INFO - 1 warning generated. 02:16:00 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 02:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:16:00 INFO - Successfully installed psutil 02:16:00 INFO - Cleaning up... 02:16:01 INFO - Return code: 0 02:16:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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')]} 02:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:16: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 mozsystemmonitor==0.3 02:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:01 INFO - 'HOME': '/Users/cltbld', 02:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:01 INFO - 'LOGNAME': 'cltbld', 02:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:01 INFO - 'MOZ_NO_REMOTE': '1', 02:16:01 INFO - 'NO_EM_RESTART': '1', 02:16:01 INFO - 'PAGER': '/bin/cat', 02:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:01 INFO - 'PWD': '/builds/slave/test', 02:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:01 INFO - 'SHELL': '/bin/bash', 02:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:01 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:01 INFO - 'USER': 'cltbld', 02:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:01 INFO - 'XPC_FLAGS': '0x0', 02:16:01 INFO - 'XPC_SERVICE_NAME': '0', 02:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:16:03 INFO - Installing collected packages: mozsystemmonitor 02:16:03 INFO - Running setup.py install for mozsystemmonitor 02:16:04 INFO - Successfully installed mozsystemmonitor 02:16:04 INFO - Cleaning up... 02:16:04 INFO - Return code: 0 02:16:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:16:04 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')]} 02:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:04 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')]} 02:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:04 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:04 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 02:16:04 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 02:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:04 INFO - 'HOME': '/Users/cltbld', 02:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:04 INFO - 'LOGNAME': 'cltbld', 02:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:04 INFO - 'MOZ_NO_REMOTE': '1', 02:16:04 INFO - 'NO_EM_RESTART': '1', 02:16:04 INFO - 'PAGER': '/bin/cat', 02:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:04 INFO - 'PWD': '/builds/slave/test', 02:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:04 INFO - 'SHELL': '/bin/bash', 02:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:04 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:04 INFO - 'USER': 'cltbld', 02:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:04 INFO - 'XPC_FLAGS': '0x0', 02:16:04 INFO - 'XPC_SERVICE_NAME': '0', 02:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:16:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:16:07 INFO - warning: no files found matching '*.txt' 02:16:07 INFO - no previously-included directories found matching 'build' 02:16:07 INFO - no previously-included directories found matching 'dist' 02:16:07 INFO - no previously-included directories found matching '.git*' 02:16:07 INFO - Installing collected packages: jsonschema, functools32 02:16:07 INFO - Running setup.py install for functools32 02:16:07 INFO - warning: no files found matching '*.txt' 02:16:07 INFO - no previously-included directories found matching 'build' 02:16:07 INFO - no previously-included directories found matching 'dist' 02:16:07 INFO - no previously-included directories found matching '.git*' 02:16:07 INFO - Successfully installed jsonschema functools32 02:16:07 INFO - Cleaning up... 02:16:07 INFO - Return code: 0 02:16:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:16:07 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')]} 02:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:07 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')]} 02:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:07 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:07 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 02:16:07 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 02:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:07 INFO - 'HOME': '/Users/cltbld', 02:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:07 INFO - 'LOGNAME': 'cltbld', 02:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:07 INFO - 'MOZ_NO_REMOTE': '1', 02:16:07 INFO - 'NO_EM_RESTART': '1', 02:16:07 INFO - 'PAGER': '/bin/cat', 02:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:07 INFO - 'PWD': '/builds/slave/test', 02:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:07 INFO - 'SHELL': '/bin/bash', 02:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:07 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:07 INFO - 'USER': 'cltbld', 02:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:07 INFO - 'XPC_FLAGS': '0x0', 02:16:07 INFO - 'XPC_SERVICE_NAME': '0', 02:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:16:07 INFO - Cleaning up... 02:16:07 INFO - Return code: 0 02:16:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:16:07 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')]} 02:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:07 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')]} 02:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:07 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:07 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 02:16:07 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 02:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:07 INFO - 'HOME': '/Users/cltbld', 02:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:07 INFO - 'LOGNAME': 'cltbld', 02:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:07 INFO - 'MOZ_NO_REMOTE': '1', 02:16:07 INFO - 'NO_EM_RESTART': '1', 02:16:07 INFO - 'PAGER': '/bin/cat', 02:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:07 INFO - 'PWD': '/builds/slave/test', 02:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:07 INFO - 'SHELL': '/bin/bash', 02:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:07 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:07 INFO - 'USER': 'cltbld', 02:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:07 INFO - 'XPC_FLAGS': '0x0', 02:16:07 INFO - 'XPC_SERVICE_NAME': '0', 02:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16: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 02:16:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:16:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:16:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:16:11 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 02:16:11 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 02:16:11 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 02:16:11 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 02:16:11 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 02:16:11 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 02:16:11 INFO - Downloading docopt-0.6.1.tar.gz 02:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:16:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:16:11 INFO - Running setup.py install for blobuploader 02:16:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:16:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:16:12 INFO - Running setup.py install for requests 02:16:12 INFO - Running setup.py install for docopt 02:16:12 INFO - Successfully installed blobuploader requests docopt 02:16:12 INFO - Cleaning up... 02:16:12 INFO - Return code: 0 02:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:12 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:12 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 02:16:12 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 02:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:12 INFO - 'HOME': '/Users/cltbld', 02:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:12 INFO - 'LOGNAME': 'cltbld', 02:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:12 INFO - 'MOZ_NO_REMOTE': '1', 02:16:12 INFO - 'NO_EM_RESTART': '1', 02:16:12 INFO - 'PAGER': '/bin/cat', 02:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:12 INFO - 'PWD': '/builds/slave/test', 02:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:12 INFO - 'SHELL': '/bin/bash', 02:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:12 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:12 INFO - 'USER': 'cltbld', 02:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:12 INFO - 'XPC_FLAGS': '0x0', 02:16:12 INFO - 'XPC_SERVICE_NAME': '0', 02:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-vHNXdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-i1kRH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pTNmkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pGRaO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-S5odut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JN66IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dLhp7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-yEyVw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:13 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-O0WryK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-F5Mv6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-f2Jhdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-vNnVQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-K7dcSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-yG8ti9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-P9bzw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xz6aCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-kPCa5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:16:14 INFO - Running setup.py install for manifestparser 02:16:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:16:15 INFO - Running setup.py install for mozcrash 02:16:15 INFO - Running setup.py install for mozdebug 02:16:15 INFO - Running setup.py install for mozdevice 02:16:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:16:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:16:15 INFO - Running setup.py install for mozfile 02:16:15 INFO - Running setup.py install for mozhttpd 02:16:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:16:15 INFO - Running setup.py install for mozinfo 02:16:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:16:15 INFO - Running setup.py install for mozInstall 02:16:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Running setup.py install for mozleak 02:16:16 INFO - Running setup.py install for mozlog 02:16:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Running setup.py install for moznetwork 02:16:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Running setup.py install for mozprocess 02:16:16 INFO - Running setup.py install for mozprofile 02:16:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:16:16 INFO - Running setup.py install for mozrunner 02:16:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:16:17 INFO - Running setup.py install for mozscreenshot 02:16:17 INFO - Running setup.py install for moztest 02:16:17 INFO - Running setup.py install for mozversion 02:16:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:16:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:16:17 INFO - Cleaning up... 02:16:17 INFO - Return code: 0 02:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:17 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')]} 02:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:17 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')]} 02:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:17 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:17 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 02:16:17 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 02:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:17 INFO - 'HOME': '/Users/cltbld', 02:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:17 INFO - 'LOGNAME': 'cltbld', 02:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:17 INFO - 'MOZ_NO_REMOTE': '1', 02:16:17 INFO - 'NO_EM_RESTART': '1', 02:16:17 INFO - 'PAGER': '/bin/cat', 02:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:17 INFO - 'PWD': '/builds/slave/test', 02:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:17 INFO - 'SHELL': '/bin/bash', 02:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:17 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:17 INFO - 'USER': 'cltbld', 02:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:17 INFO - 'XPC_FLAGS': '0x0', 02:16:17 INFO - 'XPC_SERVICE_NAME': '0', 02:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:17 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WGG5Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:17 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)) 02:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:17 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gRkl7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:17 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)) 02:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:17 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-TyQpVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-wl4Vje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-q5U4b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4GinRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-mohdv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xJd1Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-MFSlmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-2khZ1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9RsLB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:18 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)) 02:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-swMgfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:19 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)) 02:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SYKZHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:19 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)) 02:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iZcJFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:19 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)) 02:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Q3N8Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:19 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)) 02:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-B0yHri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:19 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)) 02:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-zBYqI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:19 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)) 02:16:19 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)) 02:16:19 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)) 02:16:19 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)) 02:16:19 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)) 02:16:19 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)) 02:16:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:22 INFO - Downloading blessings-1.6.tar.gz 02:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:16:22 INFO - Installing collected packages: blessings 02:16:22 INFO - Running setup.py install for blessings 02:16:22 INFO - Successfully installed blessings 02:16:22 INFO - Cleaning up... 02:16:22 INFO - Return code: 0 02:16:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:22 INFO - Reading from file tmpfile_stdout 02:16:22 INFO - Current package versions: 02:16:22 INFO - blessings == 1.6 02:16:22 INFO - blobuploader == 1.2.4 02:16:22 INFO - docopt == 0.6.1 02:16:22 INFO - functools32 == 3.2.3-2 02:16:22 INFO - jsonschema == 2.5.1 02:16:22 INFO - manifestparser == 1.1 02:16:22 INFO - mozInstall == 1.12 02:16:22 INFO - mozcrash == 0.17 02:16:22 INFO - mozdebug == 0.1 02:16:22 INFO - mozdevice == 0.48 02:16:22 INFO - mozfile == 1.2 02:16:22 INFO - mozhttpd == 0.7 02:16:22 INFO - mozinfo == 0.9 02:16:22 INFO - mozleak == 0.1 02:16:22 INFO - mozlog == 3.4 02:16:22 INFO - moznetwork == 0.27 02:16:22 INFO - mozprocess == 0.23 02:16:22 INFO - mozprofile == 0.28 02:16:22 INFO - mozrunner == 6.12 02:16:22 INFO - mozscreenshot == 0.1 02:16:22 INFO - mozsystemmonitor == 0.3 02:16:22 INFO - moztest == 0.7 02:16:22 INFO - mozversion == 1.4 02:16:22 INFO - psutil == 3.1.1 02:16:22 INFO - requests == 1.2.3 02:16:22 INFO - wsgiref == 0.1.2 02:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:22 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')]} 02:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:22 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')]} 02:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:22 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:22 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 02:16:22 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 02:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:22 INFO - 'HOME': '/Users/cltbld', 02:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:22 INFO - 'LOGNAME': 'cltbld', 02:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:22 INFO - 'MOZ_NO_REMOTE': '1', 02:16:22 INFO - 'NO_EM_RESTART': '1', 02:16:22 INFO - 'PAGER': '/bin/cat', 02:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:22 INFO - 'PWD': '/builds/slave/test', 02:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:22 INFO - 'SHELL': '/bin/bash', 02:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:22 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:22 INFO - 'USER': 'cltbld', 02:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:22 INFO - 'XPC_FLAGS': '0x0', 02:16:22 INFO - 'XPC_SERVICE_NAME': '0', 02:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 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)) 02:16:22 INFO - Cleaning up... 02:16:23 INFO - Return code: 0 02:16:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:16:23 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')]} 02:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:23 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')]} 02:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:23 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 0x104831490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0fb5a4070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, '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.mFcFnAqHd4/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.HEEloj8aBw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 02:16:23 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 02:16:23 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 02:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:23 INFO - 'HOME': '/Users/cltbld', 02:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:23 INFO - 'LOGNAME': 'cltbld', 02:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:23 INFO - 'MOZ_NO_REMOTE': '1', 02:16:23 INFO - 'NO_EM_RESTART': '1', 02:16:23 INFO - 'PAGER': '/bin/cat', 02:16:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:23 INFO - 'PWD': '/builds/slave/test', 02:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:23 INFO - 'SHELL': '/bin/bash', 02:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:23 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:23 INFO - 'USER': 'cltbld', 02:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:23 INFO - 'XPC_FLAGS': '0x0', 02:16:23 INFO - 'XPC_SERVICE_NAME': '0', 02:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:16:23 INFO - Cleaning up... 02:16:23 INFO - Return code: 0 02:16:23 INFO - Running post-action listener: _resource_record_post_action 02:16:23 INFO - Running post-action listener: _start_resource_monitoring 02:16:23 INFO - Starting resource monitoring. 02:16:23 INFO - [mozharness: 2016-11-14 10:16:23.298071Z] Finished create-virtualenv step (success) 02:16:23 INFO - [mozharness: 2016-11-14 10:16:23.298899Z] Running install step. 02:16:23 INFO - Running pre-action listener: _resource_record_pre_action 02:16:23 INFO - Running main action method: install 02:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:23 INFO - Reading from file tmpfile_stdout 02:16:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:16:23 INFO - Reading from file tmpfile_stdout 02:16:23 INFO - Output received: 02:16:23 INFO - Usage: mozinstall [options] installer 02:16:23 INFO - Options: 02:16:23 INFO - -h, --help show this help message and exit 02:16:23 INFO - -d DEST, --destination=DEST 02:16:23 INFO - Directory to install application into. [default: 02:16:23 INFO - "/builds/slave/test"] 02:16:23 INFO - --app=APP Application being installed. [default: firefox] 02:16:23 INFO - mkdir: /builds/slave/test/build/application 02:16:23 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'] 02:16:23 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 02:16:55 INFO - Reading from file tmpfile_stdout 02:16:55 INFO - Output received: 02:16:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:16:55 INFO - Running post-action listener: _resource_record_post_action 02:16:55 INFO - [mozharness: 2016-11-14 10:16:55.801165Z] Finished install step (success) 02:16:55 INFO - [mozharness: 2016-11-14 10:16:55.801300Z] Running run-tests step. 02:16:55 INFO - Running pre-action listener: _resource_record_pre_action 02:16:55 INFO - Running main action method: run_tests 02:16:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:16:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:16:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:16:55 INFO - 2016-11-14 02:16:55.816 screenresolution[1927:15476] starting screenresolution argv=screenresolution get 02:16:55 INFO - 2016-11-14 02:16:55.818 screenresolution[1927:15476] Display 0: 1600x1200x32@60 02:16:55 INFO - 2016-11-14 02:16:55.824 screenresolution[1928:15478] starting screenresolution argv=screenresolution list 02:16:55 INFO - Available Modes on Display 0 02:16:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:16:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:16:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:16:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:16:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:16:56 INFO - Intel Iris: 02:16:56 INFO - Chipset Model: Intel Iris 02:16:56 INFO - Type: GPU 02:16:56 INFO - Bus: Built-In 02:16:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:16:56 INFO - Vendor: Intel (0x8086) 02:16:56 INFO - Device ID: 0x0a2e 02:16:56 INFO - Revision ID: 0x0009 02:16:56 INFO - Displays: 02:16:56 INFO - Display: 02:16:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:16:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:16:56 INFO - Display Serial Number: 1600x1200 60 02:16:56 INFO - Main Display: Yes 02:16:56 INFO - Mirror: Off 02:16:56 INFO - Online: Yes 02:16:56 INFO - Rotation: Supported 02:16:56 INFO - Return code: 0 02:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:16:56 INFO - Python 2.7.3 02:16:56 INFO - Return code: 0 02:16:56 INFO - grabbing minidump binary from tooltool 02:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:56 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 0x104645d30>, '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 0x1044abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:16:56 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 02:16:56 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 02:16:56 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 02:16:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:16:56 INFO - Return code: 0 02:16:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:16:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:16:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:16:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:16:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:16:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mFcFnAqHd4/Render', 02:16:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:56 INFO - 'HOME': '/Users/cltbld', 02:16:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:56 INFO - 'LOGNAME': 'cltbld', 02:16:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:16:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:56 INFO - 'MOZ_NO_REMOTE': '1', 02:16:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:16:56 INFO - 'NO_EM_RESTART': '1', 02:16:56 INFO - 'PAGER': '/bin/cat', 02:16:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:56 INFO - 'PWD': '/builds/slave/test', 02:16:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:16:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:56 INFO - 'SHELL': '/bin/bash', 02:16:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEEloj8aBw/Listeners', 02:16:56 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 02:16:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:56 INFO - 'USER': 'cltbld', 02:16:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:56 INFO - 'XPC_FLAGS': '0x0', 02:16:56 INFO - 'XPC_SERVICE_NAME': '0', 02:16:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:16:56 INFO - mozversion application_buildid: 20161114004005 02:16:56 INFO - mozversion application_changeset: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 02:16:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:16:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:16:56 INFO - mozversion application_name: Firefox 02:16:56 INFO - mozversion application_remotingname: firefox-dev 02:16:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:16:56 INFO - mozversion application_vendor: Mozilla 02:16:56 INFO - mozversion application_version: 51.0a2 02:16:56 INFO - mozversion platform_buildid: 20161114004005 02:16:56 INFO - mozversion platform_changeset: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 02:16:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:16:56 INFO - mozversion platform_version: 51.0a2 02:16:56 INFO - using testdate: 1479118616 02:16:56 INFO - actual date: 1479118616 02:16:56 INFO - starting webserver on 'localhost:51598' 02:16:56 INFO - SUITE-START | Running 2 tests 02:16:56 INFO - TEST-START | dromaeo_css 02:16:56 INFO - operating with platform_type : mac_ 02:16:56 INFO - Initialising browser for dromaeo_css test... 02:16:56 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp2eB_6B/profile http://localhost:51598/getInfo.html) 02:16:58 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 02:16:58 INFO - PROCESS | 1938 | colorDepth:24 02:16:58 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 02:16:58 INFO - PROCESS | 1938 | __metrics 02:16:58 INFO - PROCESS | 1938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:16:58 INFO - PROCESS | 1938 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:59 INFO - TEST-INFO | 1938: exit 0 02:16:59 INFO - Browser initialized. 02:16:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:59 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp2eB_6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:11 INFO - PROCESS | 1941 | RSS: Main: 219889664 02:17:11 INFO - PROCESS | 1941 | 02:18:03 INFO - PROCESS | 1941 | 1479118683251 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] 02:20:14 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51598/tests/dromaeo/cssquery-ext.html) 02:20:16 INFO - PROCESS | 1941 | RSS: Main: 411480064 02:20:16 INFO - PROCESS | 1941 | 02:23:19 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-ext.html (next: http://localhost:51598/tests/dromaeo/cssquery-jquery.html) 02:23:20 INFO - PROCESS | 1941 | RSS: Main: 349962240 02:23:20 INFO - PROCESS | 1941 | 02:26:22 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51598/tests/dromaeo/cssquery-mootools.html) 02:26:23 INFO - PROCESS | 1941 | RSS: Main: 321146880 02:26:23 INFO - PROCESS | 1941 | 02:29:25 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51598/tests/dromaeo/cssquery-prototype.html) 02:29:26 INFO - PROCESS | 1941 | RSS: Main: 315023360 02:29:26 INFO - PROCESS | 1941 | 02:32:29 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51598/tests/dromaeo/cssquery-yui.html) 02:32:30 INFO - PROCESS | 1941 | RSS: Main: 311644160 02:32:30 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51598/tests/dromaeo/cssquery-yui.html (next: http://localhost:51598/tests/dromaeo/cssquery-dojo.html) 02:35:33 INFO - PROCESS | 1941 | RSS: Main: 361603072 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | __start_tp_report 02:35:33 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 02:35:33 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 02:35:33 INFO - PROCESS | 1941 | |i|pagename|runs| 02:35:33 INFO - PROCESS | 1941 | |0;dojo.html;2890.248535380801;3306.2726200235948;3335.683110104541;3350.865965361386;3381.509681096241;5659.773609055638;5680.005998950178;5703.087505999036;5706.201131841541;5719.19931209631;5645.774169033244;5713.857153571163;5718.571107166958;5735.426457354262;5755.25181726376;5173.146430838907;5195.506426889439;5216.713080780574;5246.081935661244;5284.603654725892;5161.845144645667;5167.328247327842;5167.48325167484;5207.062728708831;5302.734863256841;5308.389535203462;5314;5319.175527793179;5332.33345831771;5362.624616276862;5252.8161514347;5300.151975683911;5307.097793375136;5308.5487733542695;5319.867003324909;5170.1986192140275;5232.973835130838;5245.606579506514;5246.685198888079;5275.155975043975;5547.278853749027;5650.604457687963;5661.094224923992;5688;5701.14482827575;6095.786647467362;6102.69172118162;6113.289413450626;6114.266954506099;6123.343628574293;6220.440160385542;6224;6292.968535157341;6297.33877942814;6322.336154703736;5471.534919531805;5781.739821707991;5801.53587712982;5821.330546987066;5854.356020837705;6213.316535181127;6270.184875966186;6276.215473065867;6285.308616052231;6308.810735677937;6031.065184896261;6098.237720284965;6118.760114527574;6122.846928826815;6172.506199504119;5271.525562699376;6263.780767673201;6272.498200143978;6274;6297.842553936188;6077.453029227391;6205.052600014957;6233.2208473940755;6257.092721555349;6261.499080073583;6145.66198859067;6154.107654390178;6208.2239720034995;6223.408776166257;6277.2153480814895;4930.137225985438;4945.035718034948;4948.802047918115;4958.776855041532;4964.528369804862;4338.0890013097605;4435.733855968652;4444.599986001275;4449.777511124431;4480.439945006874;5639.718014099279;5707.315122185364;5719.513841323451;5766.3368712598585;5785.623934444332;6137.162486020116;6191.349908259568;6202.255729312511;6229.4393504584805;6250.624962502265;5688.829335119953;5727.3699893011735;5728.942710572841;5760.0207964646115;5772.365039845614;5283.365996080418;5338.386085600128;5341.919871201935;5344.412114667383;5356.7321633918145;6174.351693072163;6217.409346112112;6235.158253635701;6280.937190628218;6330.05049242608;5209.817656382009;6313.431791138636;6328.430441260124;6328.683565821599;6340.809775706736;6253.906191407224;6306.558540902093;6307.7476900925285;6311.810645680637;6334;6014.8195554133445;6074.058520929263;6088.939110608837;6202.162708034538;6223.315435302023;6162.352952940056;6249.843753906189;6287.308396076336;6307.24313082433;6321.715522801393;6136.969315153396;6155.446009859134;6161.014237721943;6176.567640265138;6187.84530386744;5288.4182739897815;6066.666333351532;6152.138700581832;6169.105479705508;6176.9073463897175;5030.817757826834;5777.277840269966;5885.823425297248;5897.085951677497;5976.521878249817;5094.719790411563;6117.522930757332;6127.930662619259;6134.631922084689;6154.353792851865;5777.277840269966;5843.357230704704;5851.8244452664785;5853.1805547222575;5855.443732845373 02:35:33 INFO - PROCESS | 1941 | |1;ext.html;451.2193904545137;452.355393564171;463.87243508035306;499.19131007767425;511.7927239468017;30629;40928.79535602321;41661.375079373836;41876.16247675052;41877;42824;43196.78401607995;43237.56762432375;43249.35125973113;43366.56633433665;8731.60707768152;9806.901930980688;9981.650642227523;9992.900070999269;9993.100620944113;8779.736607901774;12034.69913252167;12367.381630918462;12368.257904525712;12469.314187719672;10092.596296148182;10182.338148020355;12110.031197504179;12217.877821221808;12226.14416990811;9608.423494590346;10761.623343182951;12048.518059277618;12076.456559454846;12151.574694885636;11632.894874986863;11817.763644727058;11829.231099978473;11841.467133978906;11848.940755296255;31523.527147092813;40028.19943601112;40146.39780403296;40201.79899100515;40259;3316.2041110133637;3351.2962277921665;3377.3414184234084;3396.4565669492763;3734.60786617404;25043.749562504323;29451.263718407212;30673.386532269455;31270;31637;3167.224030112614;3208.7593430492807;3226.1450715560395;3226.206848614531;3266.4936934775146;527954;528867;530276;530546.9999999962;530948;33764.49353259703;34375.31249374998;58893;59304.11043834346;59430.702846486354;35198.296034079176;35598.75404360835;35613.46579801305;35618.93143205708;35633.28733425317;14795.112293262438;14905.180215088274;14958.177300248373;14967.476138335323;14975.176365300013;11585.189036767513;11773.823392649118;11794.233374830608;12637.93681031589;12750.744985100246;7362.668679909417;7425.85148297031;7643.885341719879;7884.64519096642;7910.446268761131;3179.3800208959033;3221.7100460958627;3226.9838650807064;3236.3689080629524;3244.1403028197547;942.9104235097655;962.5283611030685;973.2992245583168;977.2524019125375;1012.549415510091;28768.71231287702;29339;29640.110796676134;30407.847960760497;30427.69572304293;1037.1080870451406;1043.3114144664485;1048.2871647279771;1094.9781004379868;1108.451316598289;14839.332230049673;15026.474073407378;15183.62040948963;15405.537833865003;15520.301586428637;695438;706111;707240;708003;708143;57629.71185144047;58131.837363252496;58147;58171.418285817446;58288.4171158283;1062.914966802654;1255.108872700393;1351.1825345665927;1352.2224720785587;1380.6479347766256;29697.109086727432;30080;30284;30515.847420762755;31115.68884311128;47943;48339.75830120827;48475.27287090626;48478.5152148474;48498.5150148494;555166;558298;559524;559869;559899;26714;27626.44747105087;27666.861665691544;27707.445851082462;27720;37000.25999479942;45019.77490112528;45668.314975274734;45993.31010034785;46067.539324606325;37845.810770945965;38635.06824658812;38659.806700966314;38714;39135.6086439132;31548.52677209798;36507.90476285716;38934;40076.799616001736;40260.59739402569;37518.624813751514;37968.810155949046;37978.620213797505;38062.61937380591;38456.80771596236;33528.664713352555;34951.494970309526;35366.64633353736;35505.82247088748;35506.93479195525;26130;26176.083837065613;26245.880355538106;26420.603690944266;26500.337491562866 02:35:33 INFO - PROCESS | 1941 | |2;jquery.html;312.4142233312539;333.69133551464904;345.7804294273136;372.3614001986594;372.53619244041164;15160.54518364448;15825.762613560792;16022.599435014115;16712.66574668506;19870.50323741907;16766.41317553886;18673.90663046683;18696.626067478643;18894.527636809053;21091.2618058368;5912.438318359749;5958.7616495340135;6035.185249991239;6112.052631842072;6112.969435152818;4180.226658068252;6040.607360521552;6149.354317796612;6157.7536898524;6166.568340216187;4408.052268762215;4422.579854913794;6831.521793474459;6909.896351554731;6911.377975982161;4637.281221410653;5897.439743224387;6879.17449906012;6910.170779506441;6915.066466027098;5039.521245481674;6060.181875446802;6063.7574497020505;6067.2719273687;6071.726772295257;13213.273269970148;22453.55092898149;24507.264782056565;25587;25710;2200.108955872874;2251.5271792923504;2270.3416009357265;2274.4200228941513;2292.5758734634146;9760.560774765152;9769.658061967797;10413.062824345845;11753.823692644617;13100.60698179056;1833.9174737136861;1874.812518748128;1883.133758471105;1913.3781521005728;1927.267638297438;117820.41089794497;120673;123443;128631.35684321613;131853;9578.13796758295;9978.052085051908;10105.040021197974;10317.226208034428;11586.304821710724;12516.3741812909;12570.245785252913;12571.120021598583;12590.24458532491;12620.747585048248;8081.919180808117;8217.465864718773;8239.629216685264;8341.332693384515;8358.038825535019;8611.741647750578;8639.265662418766;8653.048164701877;8771.517566533774;8794.60424280909;3797.5632802227547;3848.1534062506203;3917.334053210961;3982.143839074613;3988.4216788565495;1577.810662720458;1847.1780057874387;1896.3173257627243;1896.5258685328668;1904.8952307623215;727.483486724421;860.7632900952163;937.8077494113691;939.7462685074992;958.3755534369317;21356.679649805264;22138.114475421124;22149.446263843533;22184;22206;894.8568229083446;911.7401540560908;934.9252059835197;936.4381371177375;964.2141654551518;10795.56817727282;11495.992432916912;11496.96527312546;11552.018078463258;11579.247348922461;611094;612855;617162;619308;628729;90258.64612030824;123721.38139309245;136544.90841979953;137512;142465;435.1362545347483;454.0125227629892;455.26247479083435;913.0869130869131;954.3891909178132;9099.36304458708;11084.556617735201;11275;11368.514984012294;11736.647900562997;57595.848083038945;59355.703221483614;59414.81170376482;59889.10166347595;60244.397556023876;56531;71955.92066118908;78634.2136578627;80623.95320351115;86420;7985;8150.796230094295;8378.790530236549;8379.413441059067;8519.91480085216;10630.468476576294;11945.462454189756;12785.744285114431;12791.42438590247;13463.192208467523;11055.281406708538;11154.609588664358;11188.608398706006;11507.309561426342;11574.479148438171;10138.087572118544;10388;10718.678439646823;10807.08139808125;11226.607068752555;11302.321860688386;11453.427328633368;11462.770744584896;11568.652940411801;11754.70613234676;7985.48094373887;8113.7565873023905;8209.71266005687;8319;8349.916500835157;10201.438920859127;11132.276402033842;11178.0498657615;11365.886341136813;11558.595449159575 02:35:33 INFO - PROCESS | 1941 | |3;mootools.html;1493.7983372244746;1499.595109320483;1681.5207665815244;1847.011848660965;1850.0657168130092;8079.676812927476;8382.916170838289;8539.871901921468;9073.909260907398;9076.954615226923;8222.794430139249;8572.485650860952;8817.206451419372;8841.602127904243;8989.190972812445;2407.807375409972;2431.8662473563945;2435.9391015224583;2436.805055595557;2438.9634155487684;2109.662454007359;2195.4511372156962;2372.5373552157334;2388.128333158393;2422.648715936188;1969.5568497088184;2166.8483206175497;2320.153144102407;2393.9760602394012;2405.0740464920955;1766.3552803226858;2337.754535773753;2374.382660508263;2386.6539351794067;2389.23544465771;2340.958273568263;2360.5986982213067;2363.078399424226;2365.562370961378;2370.0401337458356;8740.169683880085;8796.8680469793;8823.514706691129;8843.33674974373;8855.203031727175;5333.359996800409;5408.296921400232;5517.944820551783;5519.613627046108;5520.392756796749;2999.35513864518;3676.466912297702;3720.107174278181;3751.4372844073337;3759.3797023491366;1103.3710784852638;1103.564092183591;1106.441247170182;1117.5753213778712;1131.615250814727;10955.287906286145;10957.17821163416;11037.337759734442;11039.72400689981;11046.729626093022;4260.424842646203;4317.784110794448;4397.626201772885;4399.780010999437;4682.2508398656055;9267.67563135287;9277.257819374434;9284.489353085644;9289.489078100634;9302.720918372459;5299.311089558333;5305.36335639718;5319.962607291618;5321.707306098125;5321.787128514893;4825.613950883921;4872.707637541759;4934.087193869145;4976.62675299354;4985.277134815431;3589.335972845032;3594.370985077601;3634.400323946519;3664.5785734640326;3688.483612294281;1038.1642777563982;1093.6008356949815;1096.627146770102;1108.1135091926426;1109.7669489407153;750.9061367329084;767.7428061599315;795.7135431244748;800.6357107516183;875.2079368171815;5546.833594992076;5643.322801263875;5754.913676294859;5779.111512785018;6046.546509011841;800.7068584236416;921.1157289002499;941.8963913969458;970.5535453691381;1034.5499707627055;3402.2344972381015;3930.390789427643;4019.598040195957;4032.0927791246736;4165.125323682;10720.356778593154;10952.616658416917;11051;11058.723531911766;11059;10745.355278683148;10750.623728169476;10984.286021408583;10990.065844403156;10991.395473248887;7936.206379362133;8234.341252699769;8320.209580089882;8350.373721970876;8382.119877412784;5901.232839730807;6035.456808887221;6117.388261173847;6131.049687298476;6204.689765511796;9638.469884156159;10048.547815348473;10305.53625086888;10319.845202321821;10326;10142;10393.844092338772;10534;10539.367637941748;10558.472076396303;7385.187629360874;7601.885971710318;7720.922790772021;7794.2985131338455;7805.102413222552;8335.624896879775;8359.247667709935;8439.873401898854;8440.409171357946;8442.704505342284;7500.887486687595;7521.360684341892;7531.209223031503;7581.772546823604;7601.847963040819;7110.964445177948;7292.270772922665;7404.666789994355;7407.62961851916;7409.036825212688;7005.509614326948;7076;7130.607816570138;7133.643317834191;7138.571685698875;4829.517048295143;4934.161192597196;4999.750012499433;5063.189889617791;5172.19830926207;5001.299818025406;5043.5460808527405;5043.747812609428;5126.026055049529;5153.484651534816 02:35:33 INFO - PROCESS | 1941 | |4;prototype.html;270.2015544067281;297.36215817072383;300.95786589877423;303.2842491719543;304.9904815062144;4178.910544727636;4401.845935392262;4523.4797998230215;5259.76331065102;5260.973695131529;4896.583790377822;5179.896402071966;5199.272101905727;5204.921926171101;5251.658642188255;3486.0761898097026;3804.410316400962;3832.8466861325514;3951.427043078752;3955.011247188203;3483.4426491761324;3627.3833448313717;3759.9096262083963;3834.9041273968096;4055.959440405588;3317.5023746437987;3482.9129271768156;3558.6619271169197;3657.670809627133;3924.4113382992496;3499.4051011328006;3513.420285652877;3625.5286812714444;3801.904952376185;3868.497095377611;2838.4748821468093;3476.9652303476896;3508.210652603144;3529.188286694049;3530.4704294355797;3853.98073009636;4181.790910454495;4957.157283261854;5064.265681476202;5104.566111880495;3614.945775813365;4182.247195504808;4567.840125595588;4571.611413029863;4583.679142460029;5350.49170328822;5398.379186393537;5408.215808707755;5458.344998600153;5470.316210473691;3143.5441860930036;3627.292677927805;3741.1021354874906;3749.9250014999548;3799.772013679188;4530.29780384041;4927.260910863363;5603.327600687903;5653.293338332708;5770.451807078362;3783.2055268393397;3811.2949104415216;3822.6750726188584;3825.7895815729844;3826.521684789401;3692.9446058309145;3870.606581630611;3876.9418458723144;3887.13417559573;3896.532416110085;4197.18154959786;4212.91574168521;4496.57282558163;4535.9546404536195;4582.862514124582;4477.597016268552;5475.342958844964;5547.306586676666;5585.463997400748;5618.69097199658;1209.3953023488257;1293.3316022331087;1309.8428188617427;1312.5471712259255;1326.383231797219;773.8258891749424;791.3827214772372;799.5402643479906;802.60672270587;815.6655771133807;3927.9558342284386;4351.499577548622;4417.337399390053;4872.926906096412;5077.923831142536;4669.34629151919;5065.417476990119;5092.9236061459105;5164.767585458663;5244.475552444725;4541.024654275401;4688.390509233778;4859.927101093486;4937.555619994146;5183.533481986639;2382.5115851250453;2610.6475625790276;2847.135126492151;2897.6377952755906;2939.3680358722977;5813.273340832396;5856.8535786604825;5903.291605007426;5909.965755992684;5918.484644026357;5479.5342395896;5765.250517432707;5784.508316793035;5786.537077033827;5787.681677507693;4976.4525902150735;5759.596828222068;5827.24245848037;5833.941660583339;5936.753281810868;5372.791121997519;5500.972495137498;5583.246261754611;5628.493435590816;5642.322921249476;5138.3577052868395;5521.806736764354;5521.834344969658;5590.413006634245;5616.915746263728;4821.373221481325;5862.472377486047;5901.409859014064;5944.464998150187;5975.850603734768;3343.5987681478377;3740.1584643455003;3751.1934933989323;3760.1351689112203;3793.8890110109446;4608.778673651552;4993.503248375812;5560.7851685971045;5645.887082258249;5717.685527295872;4579.519150489284;5175;5489.643173193889;5496.065668836228;5537.723113844372;5425.891482170414;5491.725413729378;5518.365387980433;5536.75084621201;5580.693061881636;5116.232565115262;5117.513836185556;5280.551153152025;5348.358197016383;5416.918746218731;4777.996620709551;5192;5297.602679799107;5438.782448702008;5444.537214336668;5234.738263086907;5299.655522391032;5346.6257361985845;5408.810691625774;5426.593005524523 02:35:33 INFO - PROCESS | 1941 | |5;yui.html;676.7732809508815;703.8275622472494;711.6370650968008;755.5844285642899;811.6509900742681;14734.484293049745;15717.292721827516;15723.213839308046;15732;15770.526884193478;14147.151170929752;14321.283935803194;14337.42650293987;14338.99627026106;14503.419863205485;663.4393937123124;674.2381109346444;681.407175757092;685.568092101975;844.2275318083946;810.092696180276;824.7690646618956;837.9162083791603;846.8179341441589;847.2798121596625;884.5135175653397;885.4421714320001;890.7060669978891;891.6834523744075;892.205936716323;698.1552321690709;720.5280541245493;723.3056265984661;881.9691310804124;884.9646014159458;532.4090259811607;534.2627174499205;630.4011189370117;650.6681592387869;654.7970129259945;14764.852351476455;14786.112833230041;14791.186484743335;14795.112293262331;14804.70390592193;13673.384697688627;13893.027488075839;13958.511452099128;14004;14078.436862525487;11953.402329883558;12283.815742763865;12436.8134477982;12461.1900226485;12877.291748953803;4535.750533720644;4535.931961020588;4550.112728018038;4617.976910115428;4733.526647335273;109451;112115.87884121136;113129;119489;119578.80421195764;8666.696665616673;10779.514921828537;10870.18473614482;11186.552537898555;11268.985791278661;18058.3679571217;21973.560528789334;21982.45043873916;22019.559608808053;22050.779492205194;7608.80977975544;7864.882026769603;8074.313683336864;8099.271065604006;8172.18278172178;4274.871753847389;4415.492218394861;4483.394741709827;4494.191045611756;4620.491745907947;3471.461923401877;3614.855405783739;3620.8913732588067;3624.583172935146;3628.618995005539;639.7536948274948;656.8817612829641;664.5779929744647;667.5260564998905;676.2088356622763;594.364030487383;602.9487493563008;605.8212827215982;610.6244659534354;637.6684124255454;8662.913370866338;9081.409708368936;9106.681266155652;9142.902851657711;9260;526.3631006482123;589.7906243283572;615.4952938590313;621.6798348850346;624.5191202773839;4159.708820382604;4446.888827779331;4476.261416866246;4518.638508919278;4554.544545545419;147441.52558474278;148607;156140;159736;167815.16092419703;137726;140692;140942.590574095;141020;143774;115106.84893151128;120596;120698.17207311609;122838;124875.75124248641;8491.95754021226;8533.146685331418;8741.475511469333;8761.249993808418;8886.377953543448;67274.66362668155;67746.66126669335;69417;70428.29571704422;72053.63973180311;62375.816846410155;66552.66894661983;68624;86978.130218697;96253.03746962441;13066.281354525592;13315.934725221765;13421.32893355348;13530.323483825572;13799.568484488;14214.644633884236;14628.414863405345;14998.2500874958;15005.924970375077;15398.92300538535;13573.182322192473;13687.452501899812;13805.17168969865;14074.085184462978;14549.709005819612;13589.796153057514;13755.79366309526;13988.58034258974;14133.858661413255;14181.432742690176;13721.725565488434;13758.93120534391;13763.86236137666;13767.931160344135;13894.513692020731;11096.445177741241;11360.375179364884;11439.199256051996;11586.42067896585;12051.939740301243;10328.61037054798;11290.548378064785;11501.942490287494;11641.53433862636;11743.882561174622 02:35:33 INFO - PROCESS | 1941 | __end_tp_report 02:35:33 INFO - PROCESS | 1941 | __start_cc_report 02:35:33 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1925 02:35:33 INFO - PROCESS | 1941 | __end_cc_report 02:35:33 INFO - PROCESS | 1941 | __startTimestamp1479119733847__endTimestamp 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | ------- Summary: start ------- 02:35:33 INFO - PROCESS | 1941 | Number of tests: 6 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5715.43 Median:5851.82 stddev:647.11 (11.1%) stddev-sans-first:609.96 02:35:33 INFO - PROCESS | 1941 | Values: 2890.2 3306.3 3335.7 3350.9 3381.5 5659.8 5680.0 5703.1 5706.2 5719.2 5645.8 5713.9 5718.6 5735.4 5755.3 5173.1 5195.5 5216.7 5246.1 5284.6 5161.8 5167.3 5167.5 5207.1 5302.7 5308.4 5314.0 5319.2 5332.3 5362.6 5252.8 5300.2 5307.1 5308.5 5319.9 5170.2 5233.0 5245.6 5246.7 5275.2 5547.3 5650.6 5661.1 5688.0 5701.1 6095.8 6102.7 6113.3 6114.3 6123.3 6220.4 6224.0 6293.0 6297.3 6322.3 5471.5 5781.7 5801.5 5821.3 5854.4 6213.3 6270.2 6276.2 6285.3 6308.8 6031.1 6098.2 6118.8 6122.8 6172.5 5271.5 6263.8 6272.5 6274.0 6297.8 6077.5 6205.1 6233.2 6257.1 6261.5 6145.7 6154.1 6208.2 6223.4 6277.2 4930.1 4945.0 4948.8 4958.8 4964.5 4338.1 4435.7 4444.6 4449.8 4480.4 5639.7 5707.3 5719.5 5766.3 5785.6 6137.2 6191.3 6202.3 6229.4 6250.6 5688.8 5727.4 5728.9 5760.0 5772.4 5283.4 5338.4 5341.9 5344.4 5356.7 6174.4 6217.4 6235.2 6280.9 6330.1 5209.8 6313.4 6328.4 6328.7 6340.8 6253.9 6306.6 6307.7 6311.8 6334.0 6014.8 6074.1 6088.9 6202.2 6223.3 6162.4 6249.8 6287.3 6307.2 6321.7 6137.0 6155.4 6161.0 6176.6 6187.8 5288.4 6066.7 6152.1 6169.1 6176.9 5030.8 5777.3 5885.8 5897.1 5976.5 5094.7 6117.5 6127.9 6134.6 6154.4 5777.3 5843.4 5851.8 5853.2 5855.4 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:71142.62 Median:35282.47 stddev:161595.50 (458.0%) stddev-sans-first:161961.65 02:35:33 INFO - PROCESS | 1941 | Values: 451.2 452.4 463.9 499.2 511.8 30629.0 40928.8 41661.4 41876.2 41877.0 42824.0 43196.8 43237.6 43249.4 43366.6 8731.6 9806.9 9981.7 9992.9 9993.1 8779.7 12034.7 12367.4 12368.3 12469.3 10092.6 10182.3 12110.0 12217.9 12226.1 9608.4 10761.6 12048.5 12076.5 12151.6 11632.9 11817.8 11829.2 11841.5 11848.9 31523.5 40028.2 40146.4 40201.8 40259.0 3316.2 3351.3 3377.3 3396.5 3734.6 25043.7 29451.3 30673.4 31270.0 31637.0 3167.2 3208.8 3226.1 3226.2 3266.5 527954.0 528867.0 530276.0 530547.0 530948.0 33764.5 34375.3 58893.0 59304.1 59430.7 35198.3 35598.8 35613.5 35618.9 35633.3 14795.1 14905.2 14958.2 14967.5 14975.2 11585.2 11773.8 11794.2 12637.9 12750.7 7362.7 7425.9 7643.9 7884.6 7910.4 3179.4 3221.7 3227.0 3236.4 3244.1 942.9 962.5 973.3 977.3 1012.5 28768.7 29339.0 29640.1 30407.8 30427.7 1037.1 1043.3 1048.3 1095.0 1108.5 14839.3 15026.5 15183.6 15405.5 15520.3 695438.0 706111.0 707240.0 708003.0 708143.0 57629.7 58131.8 58147.0 58171.4 58288.4 1062.9 1255.1 1351.2 1352.2 1380.6 29697.1 30080.0 30284.0 30515.8 31115.7 47943.0 48339.8 48475.3 48478.5 48498.5 555166.0 558298.0 559524.0 559869.0 559899.0 26714.0 27626.4 27666.9 27707.4 27720.0 37000.3 45019.8 45668.3 45993.3 46067.5 37845.8 38635.1 38659.8 38714.0 39135.6 31548.5 36507.9 38934.0 40076.8 40260.6 37518.6 37968.8 37978.6 38062.6 38456.8 33528.7 34951.5 35366.6 35505.8 35506.9 26130.0 26176.1 26245.9 26420.6 26500.3 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:35313.16 Median:339.74 stddev:103200.49 (30376.7%) stddev-sans-first:103456.53 02:35:33 INFO - PROCESS | 1941 | Values: 312.4 333.7 345.8 372.4 372.5 15160.5 15825.8 16022.6 16712.7 19870.5 16766.4 18673.9 18696.6 18894.5 21091.3 5912.4 5958.8 6035.2 6112.1 6113.0 4180.2 6040.6 6149.4 6157.8 6166.6 4408.1 4422.6 6831.5 6909.9 6911.4 4637.3 5897.4 6879.2 6910.2 6915.1 5039.5 6060.2 6063.8 6067.3 6071.7 13213.3 22453.6 24507.3 25587.0 25710.0 2200.1 2251.5 2270.3 2274.4 2292.6 9760.6 9769.7 10413.1 11753.8 13100.6 1833.9 1874.8 1883.1 1913.4 1927.3 117820.4 120673.0 123443.0 128631.4 131853.0 9578.1 9978.1 10105.0 10317.2 11586.3 12516.4 12570.2 12571.1 12590.2 12620.7 8081.9 8217.5 8239.6 8341.3 8358.0 8611.7 8639.3 8653.0 8771.5 8794.6 3797.6 3848.2 3917.3 3982.1 3988.4 1577.8 1847.2 1896.3 1896.5 1904.9 727.5 860.8 937.8 939.7 958.4 21356.7 22138.1 22149.4 22184.0 22206.0 894.9 911.7 934.9 936.4 964.2 10795.6 11496.0 11497.0 11552.0 11579.2 611094.0 612855.0 617162.0 619308.0 628729.0 90258.6 123721.4 136544.9 137512.0 142465.0 435.1 454.0 455.3 913.1 954.4 9099.4 11084.6 11275.0 11368.5 11736.6 57595.8 59355.7 59414.8 59889.1 60244.4 56531.0 71955.9 78634.2 80624.0 86420.0 7985.0 8150.8 8378.8 8379.4 8519.9 10630.5 11945.5 12785.7 12791.4 13463.2 11055.3 11154.6 11188.6 11507.3 11574.5 10138.1 10388.0 10718.7 10807.1 11226.6 11302.3 11453.4 11462.8 11568.7 11754.7 7985.5 8113.8 8209.7 8319.0 8349.9 10201.4 11132.3 11178.0 11365.9 11558.6 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5707.12 Median:4980.95 stddev:3211.88 (64.5%) stddev-sans-first:3205.28 02:35:33 INFO - PROCESS | 1941 | Values: 1493.8 1499.6 1681.5 1847.0 1850.1 8079.7 8382.9 8539.9 9073.9 9077.0 8222.8 8572.5 8817.2 8841.6 8989.2 2407.8 2431.9 2435.9 2436.8 2439.0 2109.7 2195.5 2372.5 2388.1 2422.6 1969.6 2166.8 2320.2 2394.0 2405.1 1766.4 2337.8 2374.4 2386.7 2389.2 2341.0 2360.6 2363.1 2365.6 2370.0 8740.2 8796.9 8823.5 8843.3 8855.2 5333.4 5408.3 5517.9 5519.6 5520.4 2999.4 3676.5 3720.1 3751.4 3759.4 1103.4 1103.6 1106.4 1117.6 1131.6 10955.3 10957.2 11037.3 11039.7 11046.7 4260.4 4317.8 4397.6 4399.8 4682.3 9267.7 9277.3 9284.5 9289.5 9302.7 5299.3 5305.4 5320.0 5321.7 5321.8 4825.6 4872.7 4934.1 4976.6 4985.3 3589.3 3594.4 3634.4 3664.6 3688.5 1038.2 1093.6 1096.6 1108.1 1109.8 750.9 767.7 795.7 800.6 875.2 5546.8 5643.3 5754.9 5779.1 6046.5 800.7 921.1 941.9 970.6 1034.5 3402.2 3930.4 4019.6 4032.1 4165.1 10720.4 10952.6 11051.0 11058.7 11059.0 10745.4 10750.6 10984.3 10990.1 10991.4 7936.2 8234.3 8320.2 8350.4 8382.1 5901.2 6035.5 6117.4 6131.0 6204.7 9638.5 10048.5 10305.5 10319.8 10326.0 10142.0 10393.8 10534.0 10539.4 10558.5 7385.2 7601.9 7720.9 7794.3 7805.1 8335.6 8359.2 8439.9 8440.4 8442.7 7500.9 7521.4 7531.2 7581.8 7601.8 7111.0 7292.3 7404.7 7407.6 7409.0 7005.5 7076.0 7130.6 7133.6 7138.6 4829.5 4934.2 4999.8 5063.2 5172.2 5001.3 5043.5 5043.7 5126.0 5153.5 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4384.22 Median:4932.41 stddev:1382.39 (28.0%) stddev-sans-first:1351.34 02:35:33 INFO - PROCESS | 1941 | Values: 270.2 297.4 301.0 303.3 305.0 4178.9 4401.8 4523.5 5259.8 5261.0 4896.6 5179.9 5199.3 5204.9 5251.7 3486.1 3804.4 3832.8 3951.4 3955.0 3483.4 3627.4 3759.9 3834.9 4056.0 3317.5 3482.9 3558.7 3657.7 3924.4 3499.4 3513.4 3625.5 3801.9 3868.5 2838.5 3477.0 3508.2 3529.2 3530.5 3854.0 4181.8 4957.2 5064.3 5104.6 3614.9 4182.2 4567.8 4571.6 4583.7 5350.5 5398.4 5408.2 5458.3 5470.3 3143.5 3627.3 3741.1 3749.9 3799.8 4530.3 4927.3 5603.3 5653.3 5770.5 3783.2 3811.3 3822.7 3825.8 3826.5 3692.9 3870.6 3876.9 3887.1 3896.5 4197.2 4212.9 4496.6 4536.0 4582.9 4477.6 5475.3 5547.3 5585.5 5618.7 1209.4 1293.3 1309.8 1312.5 1326.4 773.8 791.4 799.5 802.6 815.7 3928.0 4351.5 4417.3 4872.9 5077.9 4669.3 5065.4 5092.9 5164.8 5244.5 4541.0 4688.4 4859.9 4937.6 5183.5 2382.5 2610.6 2847.1 2897.6 2939.4 5813.3 5856.9 5903.3 5910.0 5918.5 5479.5 5765.3 5784.5 5786.5 5787.7 4976.5 5759.6 5827.2 5833.9 5936.8 5372.8 5501.0 5583.2 5628.5 5642.3 5138.4 5521.8 5521.8 5590.4 5616.9 4821.4 5862.5 5901.4 5944.5 5975.9 3343.6 3740.2 3751.2 3760.1 3793.9 4608.8 4993.5 5560.8 5645.9 5717.7 4579.5 5175.0 5489.6 5496.1 5537.7 5425.9 5491.7 5518.4 5536.8 5580.7 5116.2 5117.5 5280.6 5348.4 5416.9 4778.0 5192.0 5297.6 5438.8 5444.5 5234.7 5299.7 5346.6 5408.8 5426.6 02:35:33 INFO - PROCESS | 1941 | 02:35:33 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:25626.77 Median:3617.87 stddev:41706.18 (1152.8%) stddev-sans-first:41781.11 02:35:33 INFO - PROCESS | 1941 | Values: 676.8 703.8 711.6 755.6 811.7 14734.5 15717.3 15723.2 15732.0 15770.5 14147.2 14321.3 14337.4 14339.0 14503.4 663.4 674.2 681.4 685.6 844.2 810.1 824.8 837.9 846.8 847.3 884.5 885.4 890.7 891.7 892.2 698.2 720.5 723.3 882.0 885.0 532.4 534.3 630.4 650.7 654.8 14764.9 14786.1 14791.2 14795.1 14804.7 13673.4 13893.0 13958.5 14004.0 14078.4 11953.4 12283.8 12436.8 12461.2 12877.3 4535.8 4535.9 4550.1 4618.0 4733.5 109451.0 112115.9 113129.0 119489.0 119578.8 8666.7 10779.5 10870.2 11186.6 11269.0 18058.4 21973.6 21982.5 22019.6 22050.8 7608.8 7864.9 8074.3 8099.3 8172.2 4274.9 4415.5 4483.4 4494.2 4620.5 3471.5 3614.9 3620.9 3624.6 3628.6 639.8 656.9 664.6 667.5 676.2 594.4 602.9 605.8 610.6 637.7 8662.9 9081.4 9106.7 9142.9 9260.0 526.4 589.8 615.5 621.7 624.5 4159.7 4446.9 4476.3 4518.6 4554.5 147441.5 148607.0 156140.0 159736.0 167815.2 137726.0 140692.0 140942.6 141020.0 143774.0 115106.8 120596.0 120698.2 122838.0 124875.8 8492.0 8533.1 8741.5 8761.2 8886.4 67274.7 67746.7 69417.0 70428.3 72053.6 62375.8 66552.7 68624.0 86978.1 96253.0 13066.3 13315.9 13421.3 13530.3 13799.6 14214.6 14628.4 14998.3 15005.9 15398.9 13573.2 13687.5 13805.2 14074.1 14549.7 13589.8 13755.8 13988.6 14133.9 14181.4 13721.7 13758.9 13763.9 13767.9 13894.5 11096.4 11360.4 11439.2 11586.4 12051.9 10328.6 11290.5 11501.9 11641.5 11743.9 02:35:33 INFO - PROCESS | 1941 | -------- Summary: end -------- 02:35:33 INFO - PROCESS | 1941 | 02:35:34 INFO - TEST-INFO | 1941: exit 0 02:35:34 INFO - TEST-OK | dromaeo_css | took 1118038ms 02:35:34 INFO - TEST-START | kraken 02:35:34 INFO - operating with platform_type : mac_ 02:35:34 INFO - Initialising browser for kraken test... 02:35:34 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpPYKzFG/profile http://localhost:51598/getInfo.html) 02:35:36 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 02:35:36 INFO - PROCESS | 1946 | colorDepth:24 02:35:36 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 02:35:36 INFO - PROCESS | 1946 | __metrics 02:35:37 INFO - PROCESS | 1946 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:35:37 INFO - PROCESS | 1946 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:37 INFO - TEST-INFO | 1946: exit 0 02:35:37 INFO - Browser initialized. 02:35:37 INFO - Running cycle 1/1 for kraken test... 02:35:37 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpPYKzFG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:50 INFO - PROCESS | 1948 | RSS: Main: 220262400 02:35:50 INFO - PROCESS | 1948 | 02:35:53 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51598/tests/kraken/driver.html?testName=audio-beat-detection) 02:35:54 INFO - PROCESS | 1948 | RSS: Main: 269967360 02:35:54 INFO - PROCESS | 1948 | 02:35:56 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51598/tests/kraken/driver.html?testName=audio-dft) 02:35:57 INFO - PROCESS | 1948 | RSS: Main: 280727552 02:35:57 INFO - PROCESS | 1948 | 02:36:00 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51598/tests/kraken/driver.html?testName=audio-fft) 02:36:00 INFO - PROCESS | 1948 | RSS: Main: 378658816 02:36:00 INFO - PROCESS | 1948 | 02:36:03 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51598/tests/kraken/driver.html?testName=audio-oscillator) 02:36:03 INFO - PROCESS | 1948 | RSS: Main: 280604672 02:36:03 INFO - PROCESS | 1948 | 02:36:05 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51598/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:36:06 INFO - PROCESS | 1948 | RSS: Main: 281493504 02:36:06 INFO - PROCESS | 1948 | 02:36:09 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51598/tests/kraken/driver.html?testName=imaging-darkroom) 02:36:09 INFO - PROCESS | 1948 | RSS: Main: 320696320 02:36:09 INFO - PROCESS | 1948 | 02:36:12 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51598/tests/kraken/driver.html?testName=imaging-desaturate) 02:36:13 INFO - PROCESS | 1948 | RSS: Main: 318087168 02:36:13 INFO - PROCESS | 1948 | 02:36:16 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51598/tests/kraken/driver.html?testName=json-parse-financial) 02:36:16 INFO - PROCESS | 1948 | RSS: Main: 316518400 02:36:16 INFO - PROCESS | 1948 | 02:36:18 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51598/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:36:18 INFO - PROCESS | 1948 | RSS: Main: 291696640 02:36:18 INFO - PROCESS | 1948 | 02:36:20 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:36:21 INFO - PROCESS | 1948 | RSS: Main: 294563840 02:36:21 INFO - PROCESS | 1948 | 02:36:23 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:36:24 INFO - PROCESS | 1948 | RSS: Main: 306864128 02:36:24 INFO - PROCESS | 1948 | 02:36:27 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:36:27 INFO - PROCESS | 1948 | RSS: Main: 310214656 02:36:27 INFO - PROCESS | 1948 | 02:36:30 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:36:31 INFO - PROCESS | 1948 | RSS: Main: 310145024 02:36:31 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:51598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51598/tests/kraken/driver.html?testName=ai-astar) 02:36:33 INFO - PROCESS | 1948 | RSS: Main: 354119680 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | __start_tp_report 02:36:33 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 02:36:33 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 02:36:33 INFO - PROCESS | 1948 | |i|pagename|runs| 02:36:33 INFO - PROCESS | 1948 | |0;ai-astar;115;113;110;113;113;112;113;110;106;114 02:36:33 INFO - PROCESS | 1948 | |1;audio-beat-detection;144;109;107;142;106;108;108;105;138;118 02:36:33 INFO - PROCESS | 1948 | |2;audio-dft;183;183;183;186;182;184;202;185;188;184 02:36:33 INFO - PROCESS | 1948 | |3;audio-fft;84;76;92;79;81;85;82;82;111;58 02:36:33 INFO - PROCESS | 1948 | |4;audio-oscillator;88;70;93;70;67;68;91;67;68;91 02:36:33 INFO - PROCESS | 1948 | |5;imaging-gaussian-blur;89;85;89;86;88;84;89;86;89;84 02:36:33 INFO - PROCESS | 1948 | |6;imaging-darkroom;97;96;96;101;97;140;151;107;97;95 02:36:33 INFO - PROCESS | 1948 | |7;imaging-desaturate;83;84;83;86;83;85;83;84;83;84 02:36:33 INFO - PROCESS | 1948 | |8;json-parse-financial;55;53;56;56;58;59;59;58;58;58 02:36:33 INFO - PROCESS | 1948 | |9;json-stringify-tinderbox;64;75;68;77;74;71;70;74;72;72 02:36:33 INFO - PROCESS | 1948 | |10;stanford-crypto-aes;83;85;83;82;88;83;86;88;89;90 02:36:33 INFO - PROCESS | 1948 | |11;stanford-crypto-ccm;139;143;149;149;152;138;137;142;165;140 02:36:33 INFO - PROCESS | 1948 | |12;stanford-crypto-pbkdf2;166;165;166;167;165;166;166;167;225;213 02:36:33 INFO - PROCESS | 1948 | |13;stanford-crypto-sha256-iterative;68;67;66;68;66;68;67;69;71;84 02:36:33 INFO - PROCESS | 1948 | __end_tp_report 02:36:33 INFO - PROCESS | 1948 | __start_cc_report 02:36:33 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,2052 02:36:33 INFO - PROCESS | 1948 | __end_cc_report 02:36:33 INFO - PROCESS | 1948 | __startTimestamp1479119793462__endTimestamp 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | ------- Summary: start ------- 02:36:33 INFO - PROCESS | 1948 | Number of tests: 14 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.60 (2.3%) stddev-sans-first:2.51 02:36:33 INFO - PROCESS | 1948 | Values: 115.0 113.0 110.0 113.0 113.0 112.0 113.0 110.0 106.0 114.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:113.50 stddev:16.21 (14.3%) stddev-sans-first:14.33 02:36:33 INFO - PROCESS | 1948 | Values: 144.0 109.0 107.0 142.0 106.0 108.0 108.0 105.0 138.0 118.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#2] audio-dft Cycles:10 Average:186.00 Median:184.50 stddev:5.89 (3.2%) stddev-sans-first:6.14 02:36:33 INFO - PROCESS | 1948 | Values: 183.0 183.0 183.0 186.0 182.0 184.0 202.0 185.0 188.0 184.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#3] audio-fft Cycles:10 Average:83.00 Median:82.00 stddev:13.19 (16.1%) stddev-sans-first:13.99 02:36:33 INFO - PROCESS | 1948 | Values: 84.0 76.0 92.0 79.0 81.0 85.0 82.0 82.0 111.0 58.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.00 stddev:11.68 (14.8%) stddev-sans-first:11.73 02:36:33 INFO - PROCESS | 1948 | Values: 88.0 70.0 93.0 70.0 67.0 68.0 91.0 67.0 68.0 91.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.50 stddev:2.13 (2.4%) stddev-sans-first:2.12 02:36:33 INFO - PROCESS | 1948 | Values: 89.0 85.0 89.0 86.0 88.0 84.0 89.0 86.0 89.0 84.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:96.00 stddev:20.39 (21.2%) stddev-sans-first:21.26 02:36:33 INFO - PROCESS | 1948 | Values: 97.0 96.0 96.0 101.0 97.0 140.0 151.0 107.0 97.0 95.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 02:36:33 INFO - PROCESS | 1948 | Values: 83.0 84.0 83.0 86.0 83.0 85.0 83.0 84.0 83.0 84.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:58.00 stddev:1.94 (3.4%) stddev-sans-first:1.92 02:36:33 INFO - PROCESS | 1948 | Values: 55.0 53.0 56.0 56.0 58.0 59.0 59.0 58.0 58.0 58.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:73.00 stddev:3.74 (5.1%) stddev-sans-first:2.74 02:36:33 INFO - PROCESS | 1948 | Values: 64.0 75.0 68.0 77.0 74.0 71.0 70.0 74.0 72.0 72.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:87.00 stddev:2.91 (3.3%) stddev-sans-first:2.92 02:36:33 INFO - PROCESS | 1948 | Values: 83.0 85.0 83.0 82.0 88.0 83.0 86.0 88.0 89.0 90.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:146.00 stddev:8.60 (5.9%) stddev-sans-first:8.81 02:36:33 INFO - PROCESS | 1948 | Values: 139.0 143.0 149.0 149.0 152.0 138.0 137.0 142.0 165.0 140.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:166.50 stddev:22.53 (13.5%) stddev-sans-first:23.57 02:36:33 INFO - PROCESS | 1948 | Values: 166.0 165.0 166.0 167.0 165.0 166.0 166.0 167.0 225.0 213.0 02:36:33 INFO - PROCESS | 1948 | 02:36:33 INFO - PROCESS | 1948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.00 stddev:5.34 (7.8%) stddev-sans-first:5.64 02:36:33 INFO - PROCESS | 1948 | Values: 68.0 67.0 66.0 68.0 66.0 68.0 67.0 69.0 71.0 84.0 02:36:33 INFO - PROCESS | 1948 | -------- Summary: end -------- 02:36:33 INFO - PROCESS | 1948 | 02:36:34 INFO - TEST-INFO | 1948: exit 0 02:36:34 INFO - TEST-OK | kraken | took 59907ms 02:36:34 INFO - SUITE-END | took 1177s 02:36:34 INFO - Completed test suite (00:19:38) 02:36:34 INFO - javascript benchmark 02:36:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2890.248535380801, 3306.2726200235948, 3335.683110104541, 3350.865965361386, 3381.509681096241, 5659.773609055638, 5680.005998950178, 5703.087505999036, 5706.201131841541, 5719.19931209631, 5645.774169033244, 5713.857153571163, 5718.571107166958, 5735.426457354262, 5755.25181726376, 5173.146430838907, 5195.506426889439, 5216.713080780574, 5246.081935661244, 5284.603654725892, 5161.845144645667, 5167.328247327842, 5167.48325167484, 5207.062728708831, 5302.734863256841, 5308.389535203462, 5314.0, 5319.175527793179, 5332.33345831771, 5362.624616276862, 5252.8161514347, 5300.151975683911, 5307.097793375136, 5308.5487733542695, 5319.867003324909, 5170.1986192140275, 5232.973835130838, 5245.606579506514, 5246.685198888079, 5275.155975043975, 5547.278853749027, 5650.604457687963, 5661.094224923992, 5688.0, 5701.14482827575, 6095.786647467362, 6102.69172118162, 6113.289413450626, 6114.266954506099, 6123.343628574293, 6220.440160385542, 6224.0, 6292.968535157341, 6297.33877942814, 6322.336154703736, 5471.534919531805, 5781.739821707991, 5801.53587712982, 5821.330546987066, 5854.356020837705, 6213.316535181127, 6270.184875966186, 6276.215473065867, 6285.308616052231, 6308.810735677937, 6031.065184896261, 6098.237720284965, 6118.760114527574, 6122.846928826815, 6172.506199504119, 5271.525562699376, 6263.780767673201, 6272.498200143978, 6274.0, 6297.842553936188, 6077.453029227391, 6205.052600014957, 6233.2208473940755, 6257.092721555349, 6261.499080073583, 6145.66198859067, 6154.107654390178, 6208.2239720034995, 6223.408776166257, 6277.2153480814895, 4930.137225985438, 4945.035718034948, 4948.802047918115, 4958.776855041532, 4964.528369804862, 4338.0890013097605, 4435.733855968652, 4444.599986001275, 4449.777511124431, 4480.439945006874, 5639.718014099279, 5707.315122185364, 5719.513841323451, 5766.3368712598585, 5785.623934444332, 6137.162486020116, 6191.349908259568, 6202.255729312511, 6229.4393504584805, 6250.624962502265, 5688.829335119953, 5727.3699893011735, 5728.942710572841, 5760.0207964646115, 5772.365039845614, 5283.365996080418, 5338.386085600128, 5341.919871201935, 5344.412114667383, 5356.7321633918145, 6174.351693072163, 6217.409346112112, 6235.158253635701, 6280.937190628218, 6330.05049242608, 5209.817656382009, 6313.431791138636, 6328.430441260124, 6328.683565821599, 6340.809775706736, 6253.906191407224, 6306.558540902093, 6307.7476900925285, 6311.810645680637, 6334.0, 6014.8195554133445, 6074.058520929263, 6088.939110608837, 6202.162708034538, 6223.315435302023, 6162.352952940056, 6249.843753906189, 6287.308396076336, 6307.24313082433, 6321.715522801393, 6136.969315153396, 6155.446009859134, 6161.014237721943, 6176.567640265138, 6187.84530386744, 5288.4182739897815, 6066.666333351532, 6152.138700581832, 6169.105479705508, 6176.9073463897175, 5030.817757826834, 5777.277840269966, 5885.823425297248, 5897.085951677497, 5976.521878249817, 5094.719790411563, 6117.522930757332, 6127.930662619259, 6134.631922084689, 6154.353792851865, 5777.277840269966, 5843.357230704704, 5851.8244452664785, 5853.1805547222575, 5855.443732845373], "value": 5673.913896448918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.2193904545137, 452.355393564171, 463.87243508035306, 499.19131007767425, 511.7927239468017, 30629.0, 40928.79535602321, 41661.375079373836, 41876.16247675052, 41877.0, 42824.0, 43196.78401607995, 43237.56762432375, 43249.35125973113, 43366.56633433665, 8731.60707768152, 9806.901930980688, 9981.650642227523, 9992.900070999269, 9993.100620944113, 8779.736607901774, 12034.69913252167, 12367.381630918462, 12368.257904525712, 12469.314187719672, 10092.596296148182, 10182.338148020355, 12110.031197504179, 12217.877821221808, 12226.14416990811, 9608.423494590346, 10761.623343182951, 12048.518059277618, 12076.456559454846, 12151.574694885636, 11632.894874986863, 11817.763644727058, 11829.231099978473, 11841.467133978906, 11848.940755296255, 31523.527147092813, 40028.19943601112, 40146.39780403296, 40201.79899100515, 40259.0, 3316.2041110133637, 3351.2962277921665, 3377.3414184234084, 3396.4565669492763, 3734.60786617404, 25043.749562504323, 29451.263718407212, 30673.386532269455, 31270.0, 31637.0, 3167.224030112614, 3208.7593430492807, 3226.1450715560395, 3226.206848614531, 3266.4936934775146, 527954.0, 528867.0, 530276.0, 530546.9999999962, 530948.0, 33764.49353259703, 34375.31249374998, 58893.0, 59304.11043834346, 59430.702846486354, 35198.296034079176, 35598.75404360835, 35613.46579801305, 35618.93143205708, 35633.28733425317, 14795.112293262438, 14905.180215088274, 14958.177300248373, 14967.476138335323, 14975.176365300013, 11585.189036767513, 11773.823392649118, 11794.233374830608, 12637.93681031589, 12750.744985100246, 7362.668679909417, 7425.85148297031, 7643.885341719879, 7884.64519096642, 7910.446268761131, 3179.3800208959033, 3221.7100460958627, 3226.9838650807064, 3236.3689080629524, 3244.1403028197547, 942.9104235097655, 962.5283611030685, 973.2992245583168, 977.2524019125375, 1012.549415510091, 28768.71231287702, 29339.0, 29640.110796676134, 30407.847960760497, 30427.69572304293, 1037.1080870451406, 1043.3114144664485, 1048.2871647279771, 1094.9781004379868, 1108.451316598289, 14839.332230049673, 15026.474073407378, 15183.62040948963, 15405.537833865003, 15520.301586428637, 695438.0, 706111.0, 707240.0, 708003.0, 708143.0, 57629.71185144047, 58131.837363252496, 58147.0, 58171.418285817446, 58288.4171158283, 1062.914966802654, 1255.108872700393, 1351.1825345665927, 1352.2224720785587, 1380.6479347766256, 29697.109086727432, 30080.0, 30284.0, 30515.847420762755, 31115.68884311128, 47943.0, 48339.75830120827, 48475.27287090626, 48478.5152148474, 48498.5150148494, 555166.0, 558298.0, 559524.0, 559869.0, 559899.0, 26714.0, 27626.44747105087, 27666.861665691544, 27707.445851082462, 27720.0, 37000.25999479942, 45019.77490112528, 45668.314975274734, 45993.31010034785, 46067.539324606325, 37845.810770945965, 38635.06824658812, 38659.806700966314, 38714.0, 39135.6086439132, 31548.52677209798, 36507.90476285716, 38934.0, 40076.799616001736, 40260.59739402569, 37518.624813751514, 37968.810155949046, 37978.620213797505, 38062.61937380591, 38456.80771596236, 33528.664713352555, 34951.494970309526, 35366.64633353736, 35505.82247088748, 35506.93479195525, 26130.0, 26176.083837065613, 26245.880355538106, 26420.603690944266, 26500.337491562866], "value": 18893.413689047815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.4142233312539, 333.69133551464904, 345.7804294273136, 372.3614001986594, 372.53619244041164, 15160.54518364448, 15825.762613560792, 16022.599435014115, 16712.66574668506, 19870.50323741907, 16766.41317553886, 18673.90663046683, 18696.626067478643, 18894.527636809053, 21091.2618058368, 5912.438318359749, 5958.7616495340135, 6035.185249991239, 6112.052631842072, 6112.969435152818, 4180.226658068252, 6040.607360521552, 6149.354317796612, 6157.7536898524, 6166.568340216187, 4408.052268762215, 4422.579854913794, 6831.521793474459, 6909.896351554731, 6911.377975982161, 4637.281221410653, 5897.439743224387, 6879.17449906012, 6910.170779506441, 6915.066466027098, 5039.521245481674, 6060.181875446802, 6063.7574497020505, 6067.2719273687, 6071.726772295257, 13213.273269970148, 22453.55092898149, 24507.264782056565, 25587.0, 25710.0, 2200.108955872874, 2251.5271792923504, 2270.3416009357265, 2274.4200228941513, 2292.5758734634146, 9760.560774765152, 9769.658061967797, 10413.062824345845, 11753.823692644617, 13100.60698179056, 1833.9174737136861, 1874.812518748128, 1883.133758471105, 1913.3781521005728, 1927.267638297438, 117820.41089794497, 120673.0, 123443.0, 128631.35684321613, 131853.0, 9578.13796758295, 9978.052085051908, 10105.040021197974, 10317.226208034428, 11586.304821710724, 12516.3741812909, 12570.245785252913, 12571.120021598583, 12590.24458532491, 12620.747585048248, 8081.919180808117, 8217.465864718773, 8239.629216685264, 8341.332693384515, 8358.038825535019, 8611.741647750578, 8639.265662418766, 8653.048164701877, 8771.517566533774, 8794.60424280909, 3797.5632802227547, 3848.1534062506203, 3917.334053210961, 3982.143839074613, 3988.4216788565495, 1577.810662720458, 1847.1780057874387, 1896.3173257627243, 1896.5258685328668, 1904.8952307623215, 727.483486724421, 860.7632900952163, 937.8077494113691, 939.7462685074992, 958.3755534369317, 21356.679649805264, 22138.114475421124, 22149.446263843533, 22184.0, 22206.0, 894.8568229083446, 911.7401540560908, 934.9252059835197, 936.4381371177375, 964.2141654551518, 10795.56817727282, 11495.992432916912, 11496.96527312546, 11552.018078463258, 11579.247348922461, 611094.0, 612855.0, 617162.0, 619308.0, 628729.0, 90258.64612030824, 123721.38139309245, 136544.90841979953, 137512.0, 142465.0, 435.1362545347483, 454.0125227629892, 455.26247479083435, 913.0869130869131, 954.3891909178132, 9099.36304458708, 11084.556617735201, 11275.0, 11368.514984012294, 11736.647900562997, 57595.848083038945, 59355.703221483614, 59414.81170376482, 59889.10166347595, 60244.397556023876, 56531.0, 71955.92066118908, 78634.2136578627, 80623.95320351115, 86420.0, 7985.0, 8150.796230094295, 8378.790530236549, 8379.413441059067, 8519.91480085216, 10630.468476576294, 11945.462454189756, 12785.744285114431, 12791.42438590247, 13463.192208467523, 11055.281406708538, 11154.609588664358, 11188.608398706006, 11507.309561426342, 11574.479148438171, 10138.087572118544, 10388.0, 10718.678439646823, 10807.08139808125, 11226.607068752555, 11302.321860688386, 11453.427328633368, 11462.770744584896, 11568.652940411801, 11754.70613234676, 7985.48094373887, 8113.7565873023905, 8209.71266005687, 8319.0, 8349.916500835157, 10201.438920859127, 11132.276402033842, 11178.0498657615, 11365.886341136813, 11558.595449159575], "value": 9175.941666640138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.7983372244746, 1499.595109320483, 1681.5207665815244, 1847.011848660965, 1850.0657168130092, 8079.676812927476, 8382.916170838289, 8539.871901921468, 9073.909260907398, 9076.954615226923, 8222.794430139249, 8572.485650860952, 8817.206451419372, 8841.602127904243, 8989.190972812445, 2407.807375409972, 2431.8662473563945, 2435.9391015224583, 2436.805055595557, 2438.9634155487684, 2109.662454007359, 2195.4511372156962, 2372.5373552157334, 2388.128333158393, 2422.648715936188, 1969.5568497088184, 2166.8483206175497, 2320.153144102407, 2393.9760602394012, 2405.0740464920955, 1766.3552803226858, 2337.754535773753, 2374.382660508263, 2386.6539351794067, 2389.23544465771, 2340.958273568263, 2360.5986982213067, 2363.078399424226, 2365.562370961378, 2370.0401337458356, 8740.169683880085, 8796.8680469793, 8823.514706691129, 8843.33674974373, 8855.203031727175, 5333.359996800409, 5408.296921400232, 5517.944820551783, 5519.613627046108, 5520.392756796749, 2999.35513864518, 3676.466912297702, 3720.107174278181, 3751.4372844073337, 3759.3797023491366, 1103.3710784852638, 1103.564092183591, 1106.441247170182, 1117.5753213778712, 1131.615250814727, 10955.287906286145, 10957.17821163416, 11037.337759734442, 11039.72400689981, 11046.729626093022, 4260.424842646203, 4317.784110794448, 4397.626201772885, 4399.780010999437, 4682.2508398656055, 9267.67563135287, 9277.257819374434, 9284.489353085644, 9289.489078100634, 9302.720918372459, 5299.311089558333, 5305.36335639718, 5319.962607291618, 5321.707306098125, 5321.787128514893, 4825.613950883921, 4872.707637541759, 4934.087193869145, 4976.62675299354, 4985.277134815431, 3589.335972845032, 3594.370985077601, 3634.400323946519, 3664.5785734640326, 3688.483612294281, 1038.1642777563982, 1093.6008356949815, 1096.627146770102, 1108.1135091926426, 1109.7669489407153, 750.9061367329084, 767.7428061599315, 795.7135431244748, 800.6357107516183, 875.2079368171815, 5546.833594992076, 5643.322801263875, 5754.913676294859, 5779.111512785018, 6046.546509011841, 800.7068584236416, 921.1157289002499, 941.8963913969458, 970.5535453691381, 1034.5499707627055, 3402.2344972381015, 3930.390789427643, 4019.598040195957, 4032.0927791246736, 4165.125323682, 10720.356778593154, 10952.616658416917, 11051.0, 11058.723531911766, 11059.0, 10745.355278683148, 10750.623728169476, 10984.286021408583, 10990.065844403156, 10991.395473248887, 7936.206379362133, 8234.341252699769, 8320.209580089882, 8350.373721970876, 8382.119877412784, 5901.232839730807, 6035.456808887221, 6117.388261173847, 6131.049687298476, 6204.689765511796, 9638.469884156159, 10048.547815348473, 10305.53625086888, 10319.845202321821, 10326.0, 10142.0, 10393.844092338772, 10534.0, 10539.367637941748, 10558.472076396303, 7385.187629360874, 7601.885971710318, 7720.922790772021, 7794.2985131338455, 7805.102413222552, 8335.624896879775, 8359.247667709935, 8439.873401898854, 8440.409171357946, 8442.704505342284, 7500.887486687595, 7521.360684341892, 7531.209223031503, 7581.772546823604, 7601.847963040819, 7110.964445177948, 7292.270772922665, 7404.666789994355, 7407.62961851916, 7409.036825212688, 7005.509614326948, 7076.0, 7130.607816570138, 7133.643317834191, 7138.571685698875, 4829.517048295143, 4934.161192597196, 4999.750012499433, 5063.189889617791, 5172.19830926207, 5001.299818025406, 5043.5460808527405, 5043.747812609428, 5126.026055049529, 5153.484651534816], "value": 4555.842139473811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.2015544067281, 297.36215817072383, 300.95786589877423, 303.2842491719543, 304.9904815062144, 4178.910544727636, 4401.845935392262, 4523.4797998230215, 5259.76331065102, 5260.973695131529, 4896.583790377822, 5179.896402071966, 5199.272101905727, 5204.921926171101, 5251.658642188255, 3486.0761898097026, 3804.410316400962, 3832.8466861325514, 3951.427043078752, 3955.011247188203, 3483.4426491761324, 3627.3833448313717, 3759.9096262083963, 3834.9041273968096, 4055.959440405588, 3317.5023746437987, 3482.9129271768156, 3558.6619271169197, 3657.670809627133, 3924.4113382992496, 3499.4051011328006, 3513.420285652877, 3625.5286812714444, 3801.904952376185, 3868.497095377611, 2838.4748821468093, 3476.9652303476896, 3508.210652603144, 3529.188286694049, 3530.4704294355797, 3853.98073009636, 4181.790910454495, 4957.157283261854, 5064.265681476202, 5104.566111880495, 3614.945775813365, 4182.247195504808, 4567.840125595588, 4571.611413029863, 4583.679142460029, 5350.49170328822, 5398.379186393537, 5408.215808707755, 5458.344998600153, 5470.316210473691, 3143.5441860930036, 3627.292677927805, 3741.1021354874906, 3749.9250014999548, 3799.772013679188, 4530.29780384041, 4927.260910863363, 5603.327600687903, 5653.293338332708, 5770.451807078362, 3783.2055268393397, 3811.2949104415216, 3822.6750726188584, 3825.7895815729844, 3826.521684789401, 3692.9446058309145, 3870.606581630611, 3876.9418458723144, 3887.13417559573, 3896.532416110085, 4197.18154959786, 4212.91574168521, 4496.57282558163, 4535.9546404536195, 4582.862514124582, 4477.597016268552, 5475.342958844964, 5547.306586676666, 5585.463997400748, 5618.69097199658, 1209.3953023488257, 1293.3316022331087, 1309.8428188617427, 1312.5471712259255, 1326.383231797219, 773.8258891749424, 791.3827214772372, 799.5402643479906, 802.60672270587, 815.6655771133807, 3927.9558342284386, 4351.499577548622, 4417.337399390053, 4872.926906096412, 5077.923831142536, 4669.34629151919, 5065.417476990119, 5092.9236061459105, 5164.767585458663, 5244.475552444725, 4541.024654275401, 4688.390509233778, 4859.927101093486, 4937.555619994146, 5183.533481986639, 2382.5115851250453, 2610.6475625790276, 2847.135126492151, 2897.6377952755906, 2939.3680358722977, 5813.273340832396, 5856.8535786604825, 5903.291605007426, 5909.965755992684, 5918.484644026357, 5479.5342395896, 5765.250517432707, 5784.508316793035, 5786.537077033827, 5787.681677507693, 4976.4525902150735, 5759.596828222068, 5827.24245848037, 5833.941660583339, 5936.753281810868, 5372.791121997519, 5500.972495137498, 5583.246261754611, 5628.493435590816, 5642.322921249476, 5138.3577052868395, 5521.806736764354, 5521.834344969658, 5590.413006634245, 5616.915746263728, 4821.373221481325, 5862.472377486047, 5901.409859014064, 5944.464998150187, 5975.850603734768, 3343.5987681478377, 3740.1584643455003, 3751.1934933989323, 3760.1351689112203, 3793.8890110109446, 4608.778673651552, 4993.503248375812, 5560.7851685971045, 5645.887082258249, 5717.685527295872, 4579.519150489284, 5175.0, 5489.643173193889, 5496.065668836228, 5537.723113844372, 5425.891482170414, 5491.725413729378, 5518.365387980433, 5536.75084621201, 5580.693061881636, 5116.232565115262, 5117.513836185556, 5280.551153152025, 5348.358197016383, 5416.918746218731, 4777.996620709551, 5192.0, 5297.602679799107, 5438.782448702008, 5444.537214336668, 5234.738263086907, 5299.655522391032, 5346.6257361985845, 5408.810691625774, 5426.593005524523], "value": 3941.451599567162, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7732809508815, 703.8275622472494, 711.6370650968008, 755.5844285642899, 811.6509900742681, 14734.484293049745, 15717.292721827516, 15723.213839308046, 15732.0, 15770.526884193478, 14147.151170929752, 14321.283935803194, 14337.42650293987, 14338.99627026106, 14503.419863205485, 663.4393937123124, 674.2381109346444, 681.407175757092, 685.568092101975, 844.2275318083946, 810.092696180276, 824.7690646618956, 837.9162083791603, 846.8179341441589, 847.2798121596625, 884.5135175653397, 885.4421714320001, 890.7060669978891, 891.6834523744075, 892.205936716323, 698.1552321690709, 720.5280541245493, 723.3056265984661, 881.9691310804124, 884.9646014159458, 532.4090259811607, 534.2627174499205, 630.4011189370117, 650.6681592387869, 654.7970129259945, 14764.852351476455, 14786.112833230041, 14791.186484743335, 14795.112293262331, 14804.70390592193, 13673.384697688627, 13893.027488075839, 13958.511452099128, 14004.0, 14078.436862525487, 11953.402329883558, 12283.815742763865, 12436.8134477982, 12461.1900226485, 12877.291748953803, 4535.750533720644, 4535.931961020588, 4550.112728018038, 4617.976910115428, 4733.526647335273, 109451.0, 112115.87884121136, 113129.0, 119489.0, 119578.80421195764, 8666.696665616673, 10779.514921828537, 10870.18473614482, 11186.552537898555, 11268.985791278661, 18058.3679571217, 21973.560528789334, 21982.45043873916, 22019.559608808053, 22050.779492205194, 7608.80977975544, 7864.882026769603, 8074.313683336864, 8099.271065604006, 8172.18278172178, 4274.871753847389, 4415.492218394861, 4483.394741709827, 4494.191045611756, 4620.491745907947, 3471.461923401877, 3614.855405783739, 3620.8913732588067, 3624.583172935146, 3628.618995005539, 639.7536948274948, 656.8817612829641, 664.5779929744647, 667.5260564998905, 676.2088356622763, 594.364030487383, 602.9487493563008, 605.8212827215982, 610.6244659534354, 637.6684124255454, 8662.913370866338, 9081.409708368936, 9106.681266155652, 9142.902851657711, 9260.0, 526.3631006482123, 589.7906243283572, 615.4952938590313, 621.6798348850346, 624.5191202773839, 4159.708820382604, 4446.888827779331, 4476.261416866246, 4518.638508919278, 4554.544545545419, 147441.52558474278, 148607.0, 156140.0, 159736.0, 167815.16092419703, 137726.0, 140692.0, 140942.590574095, 141020.0, 143774.0, 115106.84893151128, 120596.0, 120698.17207311609, 122838.0, 124875.75124248641, 8491.95754021226, 8533.146685331418, 8741.475511469333, 8761.249993808418, 8886.377953543448, 67274.66362668155, 67746.66126669335, 69417.0, 70428.29571704422, 72053.63973180311, 62375.816846410155, 66552.66894661983, 68624.0, 86978.130218697, 96253.03746962441, 13066.281354525592, 13315.934725221765, 13421.32893355348, 13530.323483825572, 13799.568484488, 14214.644633884236, 14628.414863405345, 14998.2500874958, 15005.924970375077, 15398.92300538535, 13573.182322192473, 13687.452501899812, 13805.17168969865, 14074.085184462978, 14549.709005819612, 13589.796153057514, 13755.79366309526, 13988.58034258974, 14133.858661413255, 14181.432742690176, 13721.725565488434, 13758.93120534391, 13763.86236137666, 13767.931160344135, 13894.513692020731, 11096.445177741241, 11360.375179364884, 11439.199256051996, 11586.42067896585, 12051.939740301243, 10328.61037054798, 11290.548378064785, 11501.942490287494, 11641.53433862636, 11743.882561174622], "value": 7794.513493868907, "unit": "score"}], "name": "dromaeo_css", "value": 7185.944507325002, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 110.0, 113.0, 113.0, 112.0, 113.0, 110.0, 106.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 107.0, 142.0, 106.0, 108.0, 108.0, 105.0, 138.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 186.0, 182.0, 184.0, 202.0, 185.0, 188.0, 184.0], "value": 186.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 92.0, 79.0, 81.0, 85.0, 82.0, 82.0, 111.0, 58.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 70.0, 67.0, 68.0, 91.0, 67.0, 68.0, 91.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 84.0, 89.0, 86.0, 89.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 101.0, 97.0, 140.0, 151.0, 107.0, 97.0, 95.0], "value": 107.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 86.0, 83.0, 85.0, 83.0, 84.0, 83.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 56.0, 56.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 68.0, 77.0, 74.0, 71.0, 70.0, 74.0, 72.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 82.0, 88.0, 83.0, 86.0, 88.0, 89.0, 90.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 143.0, 149.0, 149.0, 152.0, 138.0, 137.0, 142.0, 165.0, 140.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 167.0, 165.0, 166.0, 166.0, 167.0, 225.0, 213.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 68.0, 66.0, 68.0, 67.0, 69.0, 71.0, 84.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1460.9, "alertThreshold": 2.0}]} 02:36:34 INFO - Return code: 0 02:36:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:36:34 INFO - # TBPL SUCCESS # 02:36:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:34 INFO - 2016-11-14 02:36:34.793 screenresolution[1952:17665] starting screenresolution argv=screenresolution get 02:36:34 INFO - 2016-11-14 02:36:34.796 screenresolution[1952:17665] Display 0: 1600x1200x32@60 02:36:34 INFO - 2016-11-14 02:36:34.802 screenresolution[1953:17668] starting screenresolution argv=screenresolution list 02:36:34 INFO - Available Modes on Display 0 02:36:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:35 INFO - Intel Iris: 02:36:35 INFO - Chipset Model: Intel Iris 02:36:35 INFO - Type: GPU 02:36:35 INFO - Bus: Built-In 02:36:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:35 INFO - Vendor: Intel (0x8086) 02:36:35 INFO - Device ID: 0x0a2e 02:36:35 INFO - Revision ID: 0x0009 02:36:35 INFO - Displays: 02:36:35 INFO - Display: 02:36:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:35 INFO - Display Serial Number: 1600x1200 60 02:36:35 INFO - Main Display: Yes 02:36:35 INFO - Mirror: Off 02:36:35 INFO - Online: Yes 02:36:35 INFO - Rotation: Supported 02:36:35 INFO - Return code: 0 02:36:35 INFO - Running post-action listener: _resource_record_post_action 02:36:35 INFO - [mozharness: 2016-11-14 10:36:35.034813Z] Finished run-tests step (success) 02:36:35 INFO - Running post-run listener: _resource_record_post_run 02:36:35 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1576960; Write bytes: 664802816; Read time: 13; Write time: 1842 02:36:35 INFO - TinderboxPrint: CPU usage
53.3% 02:36:35 INFO - TinderboxPrint: I/O read bytes / time
1,576,960 / 13 02:36:35 INFO - TinderboxPrint: I/O write bytes / time
664,802,816 / 1,842 02:36:35 INFO - TinderboxPrint: CPU idle
2,261.4 (46.7%) 02:36:35 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 02:36:35 INFO - TinderboxPrint: CPU user
1,610.0 (33.2%) 02:36:35 INFO - TinderboxPrint: Swap in / out
364,711,936 / 0 02:36:35 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358511104; Write bytes: 356323840; Read time: 27578; Write time: 705 02:36:35 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 741376; Write bytes: 297468928; Read time: 9; Write time: 1101 02:36:35 INFO - Running post-run listener: _upload_blobber_files 02:36:35 INFO - Blob upload gear active. 02:36:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:36:35 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 02:36:35 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'] 02:36:35 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 02:36:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:37 INFO - (blobuploader) - INFO - Done attempting. 02:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:38 INFO - (blobuploader) - INFO - Done attempting. 02:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:40 INFO - (blobuploader) - INFO - Done attempting. 02:36:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:36:40 INFO - Return code: 0 02:36:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:36:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:36:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c088029cc88c24e25cdbbc9927c46d622e2fa8ef3fb4e55334db5be5e7760efb668b9b923672c7c432e75b88a8a3a9ce8f497ad2b56bf4fe4c7537649571cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/365e4e932fcb03baff5b31e0f0d89103ab16f25065c1222b31bb56f6f1680d2589787d40825577dca02b006e74470b05c7d51a3b19126a1b1389b7778db76a21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/370fbd3b91bb6012b8181ad22280dd5f93e4601af6e45f294648e608930964affdc5e86494ff42b358d71d0c96a0a7434e01b3c2756d9b6b38eae1744a8a11c9"} 02:36:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:36:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:36:40 INFO - Contents: 02:36:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c088029cc88c24e25cdbbc9927c46d622e2fa8ef3fb4e55334db5be5e7760efb668b9b923672c7c432e75b88a8a3a9ce8f497ad2b56bf4fe4c7537649571cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/365e4e932fcb03baff5b31e0f0d89103ab16f25065c1222b31bb56f6f1680d2589787d40825577dca02b006e74470b05c7d51a3b19126a1b1389b7778db76a21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/370fbd3b91bb6012b8181ad22280dd5f93e4601af6e45f294648e608930964affdc5e86494ff42b358d71d0c96a0a7434e01b3c2756d9b6b38eae1744a8a11c9"} 02:36:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:36:40 INFO - Copying logs to upload dir... 02:36:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:36:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.969447 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-14 02:36:40.806000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 02:36:40.813562) ========= 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.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c088029cc88c24e25cdbbc9927c46d622e2fa8ef3fb4e55334db5be5e7760efb668b9b923672c7c432e75b88a8a3a9ce8f497ad2b56bf4fe4c7537649571cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/365e4e932fcb03baff5b31e0f0d89103ab16f25065c1222b31bb56f6f1680d2589787d40825577dca02b006e74470b05c7d51a3b19126a1b1389b7778db76a21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/370fbd3b91bb6012b8181ad22280dd5f93e4601af6e45f294648e608930964affdc5e86494ff42b358d71d0c96a0a7434e01b3c2756d9b6b38eae1744a8a11c9"} build_url:https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/XsmO1n8ZTeaUoIRVX1dm6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c088029cc88c24e25cdbbc9927c46d622e2fa8ef3fb4e55334db5be5e7760efb668b9b923672c7c432e75b88a8a3a9ce8f497ad2b56bf4fe4c7537649571cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/365e4e932fcb03baff5b31e0f0d89103ab16f25065c1222b31bb56f6f1680d2589787d40825577dca02b006e74470b05c7d51a3b19126a1b1389b7778db76a21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/370fbd3b91bb6012b8181ad22280dd5f93e4601af6e45f294648e608930964affdc5e86494ff42b358d71d0c96a0a7434e01b3c2756d9b6b38eae1744a8a11c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 02:36:40.848587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:36:40.848887) ========= 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.mFcFnAqHd4/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.HEEloj8aBw/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005386 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 02:36:40.896634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 02:36:40.896927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 02:36:40.900229) ========= ========= Total master_lag: 0.20 =========