builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0388 starttime: 1478387733.06 results: success (0) buildid: 20161105060620 builduid: b916449ac61a4df986f58c0f4ee2b98e revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.063332) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.063719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.063998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.133491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.133765) ========= 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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-05 16:15:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.18M=0.001s 2016-11-05 16:15:33 (8.18 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.619541 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.795829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.796165) ========= 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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.019543 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.926334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 16:15:33.926661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070cf059bb70aa991d50b4d266987adf26685915 --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 070cf059bb70aa991d50b4d266987adf26685915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-05 16:15:34,013 truncating revision to first 12 chars 2016-11-05 16:15:34,013 Setting DEBUG logging. 2016-11-05 16:15:34,014 attempt 1/10 2016-11-05 16:15:34,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070cf059bb70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 16:15:35,386 unpacking tar archive at: mozilla-aurora-070cf059bb70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.641656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 16:15:35.593202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.593495) ========= script_repo_revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.593894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.594157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.615299) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-05 16:15:35.615571) ========= /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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:15:35 INFO - MultiFileLogger online at 20161105 16:15:35 in /builds/slave/test 16:15:35 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 16:15:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:35 INFO - {'append_to_log': False, 16:15:35 INFO - 'base_work_dir': '/builds/slave/test', 16:15:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:15:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:35 INFO - 'branch': 'Mozilla-Aurora', 16:15:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:35 INFO - 'config_files': ('talos/mac_config.py',), 16:15:35 INFO - 'default_actions': ('clobber', 16:15:35 INFO - 'read-buildbot-config', 16:15:35 INFO - 'download-and-extract', 16:15:35 INFO - 'populate-webroot', 16:15:35 INFO - 'create-virtualenv', 16:15:35 INFO - 'install', 16:15:35 INFO - 'run-tests'), 16:15:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:35 INFO - 'download_minidump_stackwalk': True, 16:15:35 INFO - 'download_symbols': 'ondemand', 16:15:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:35 INFO - 'installer_path': 'installer.exe', 16:15:35 INFO - 'log_level': 'info', 16:15:35 INFO - 'log_name': 'talos', 16:15:35 INFO - 'log_to_console': True, 16:15:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:15:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:15:35 INFO - 'opt_config_files': (), 16:15:35 INFO - 'pip_index': False, 16:15:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:35 INFO - 'cmd': ('bash', 16:15:35 INFO - '-c', 16:15:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:35 INFO - 'enabled': True, 16:15:35 INFO - 'halt_on_failure': False, 16:15:35 INFO - 'name': 'check_screen_resolution'},), 16:15:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:35 INFO - 'cmd': ('bash', 16:15:35 INFO - '-c', 16:15:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:35 INFO - 'enabled': True, 16:15:35 INFO - 'halt_on_failure': False, 16:15:35 INFO - 'name': 'check_screen_resolution'},), 16:15:35 INFO - 'run_cmd_checks_enabled': True, 16:15:35 INFO - 'sps_profile': False, 16:15:35 INFO - 'sps_profile_interval': 0, 16:15:35 INFO - 'suite': 'dromaeojs', 16:15:35 INFO - 'system_bits': '32', 16:15:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:35 INFO - 'title': 't-yosemite-r7-0388', 16:15:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:35 INFO - 'use_talos_json': True, 16:15:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:35 INFO - 'work_dir': 'build'} 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.823217Z] Running clobber step. 16:15:35 INFO - Running pre-action listener: _resource_record_pre_action 16:15:35 INFO - Running main action method: clobber 16:15:35 INFO - rmtree: /builds/slave/test/build 16:15:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:37 INFO - Running post-action listener: _resource_record_post_action 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.394544Z] Finished clobber step (success) 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.394665Z] Running read-buildbot-config step. 16:15:37 INFO - Running pre-action listener: _resource_record_pre_action 16:15:37 INFO - Running main action method: read_buildbot_config 16:15:37 INFO - Using buildbot properties: 16:15:37 INFO - { 16:15:37 INFO - "project": "", 16:15:37 INFO - "product": "firefox", 16:15:37 INFO - "script_repo_revision": "production", 16:15:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:15:37 INFO - "repository": "", 16:15:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:15:37 INFO - "buildid": "20161105060620", 16:15:37 INFO - "pgo_build": "False", 16:15:37 INFO - "basedir": "/builds/slave/test", 16:15:37 INFO - "buildnumber": 20, 16:15:37 INFO - "slavename": "t-yosemite-r7-0388", 16:15:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:15:37 INFO - "platform": "yosemite_r7", 16:15:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:15:37 INFO - "branch": "mozilla-aurora", 16:15:37 INFO - "repo_path": "releases/mozilla-aurora", 16:15:37 INFO - "revision": "070cf059bb70aa991d50b4d266987adf26685915", 16:15:37 INFO - "stage_platform": "macosx64", 16:15:37 INFO - "builduid": "b916449ac61a4df986f58c0f4ee2b98e", 16:15:37 INFO - "slavebuilddir": "test" 16:15:37 INFO - } 16:15:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:15:37 INFO - Running post-action listener: _resource_record_post_action 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.398027Z] Finished read-buildbot-config step (success) 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.398157Z] Running download-and-extract step. 16:15:37 INFO - Running pre-action listener: _resource_record_pre_action 16:15:37 INFO - Running main action method: download_and_extract 16:15:37 INFO - mkdir: /builds/slave/test/build/tests 16:15:37 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')]} 16:15:37 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:37 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/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 16:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/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 16:15:38 INFO - Downloaded 1199 bytes. 16:15:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:38 INFO - Using the following test package requirements: 16:15:38 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:38 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:15:38 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:15:38 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'jsshell-mac.zip'], 16:15:38 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:15:38 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:38 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:15:38 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:15:38 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:15:38 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:38 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:15:38 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:39 INFO - Expected file size: 16421523 16:15:45 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 16:15:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:45 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:46 INFO - Expected file size: 16421523 16:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:15:54 INFO - Expected file size: 14414089 16:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:54 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/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 16:15:58 INFO - Downloaded 115457788 bytes. 16:15:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:58 INFO - mkdir: /builds/slave/test/properties 16:15:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:58 INFO - Contents: 16:15:58 INFO - build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:59 INFO - Running post-action listener: _resource_record_post_action 16:15:59 INFO - Running post-action listener: set_extra_try_arguments 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.647807Z] Finished download-and-extract step (success) 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.647932Z] Running populate-webroot step. 16:15:59 INFO - Running pre-action listener: _resource_record_pre_action 16:15:59 INFO - Running main action method: populate_webroot 16:15:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:59 INFO - '--tppagecycles', 16:15:59 INFO - '7'], 16:15:59 INFO - 'tests': ['tsvgm']}}, 16:15:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['damp', 'tps']}, 16:15:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['damp', 'tps']}, 16:15:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['dromaeo_dom']}, 16:15:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['basic_compositor_video']}, 16:15:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tsvgx', 16:15:59 INFO - 'tsvgr_opacity', 16:15:59 INFO - 'tart', 16:15:59 INFO - 'tscrollx', 16:15:59 INFO - 'cart']}, 16:15:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:59 INFO - 'tsvgr_opacity', 16:15:59 INFO - 'tart', 16:15:59 INFO - 'tscrollx', 16:15:59 INFO - 'cart']}, 16:15:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tp5o']}, 16:15:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['tp5o']}, 16:15:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s', 16:15:59 INFO - '--xperf_path', 16:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:59 INFO - 'tests': ['tp5n']}, 16:15:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--xperf_path', 16:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:59 INFO - 'tests': ['tp5n']}}, 16:15:59 INFO - 'talos.zip': {'path': '', 16:15:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:59 INFO - Running post-action listener: _resource_record_post_action 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.666455Z] Finished populate-webroot step (success) 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.666585Z] Running create-virtualenv step. 16:15:59 INFO - Running pre-action listener: _resource_record_pre_action 16:15:59 INFO - Running main action method: create_virtualenv 16:15:59 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:59 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 16:15:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:59 INFO - Using real prefix '/tools/python27' 16:15:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:00 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:03 INFO - Installing pip.................done. 16:16:03 INFO - Return code: 0 16:16:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:03 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')]} 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 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')]} 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:03 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 16:16:03 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 16:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:03 INFO - 'HOME': '/Users/cltbld', 16:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:03 INFO - 'LOGNAME': 'cltbld', 16:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:03 INFO - 'MOZ_NO_REMOTE': '1', 16:16:03 INFO - 'NO_EM_RESTART': '1', 16:16:03 INFO - 'PAGER': '/bin/cat', 16:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:03 INFO - 'PWD': '/builds/slave/test', 16:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:03 INFO - 'SHELL': '/bin/bash', 16:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:03 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:03 INFO - 'USER': 'cltbld', 16:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:03 INFO - 'XPC_FLAGS': '0x0', 16:16:03 INFO - 'XPC_SERVICE_NAME': '0', 16:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:03 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 16:16:03 INFO - Cleaning up... 16:16:03 INFO - Return code: 0 16:16:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:03 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')]} 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 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')]} 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:03 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 16:16:03 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 16:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:03 INFO - 'HOME': '/Users/cltbld', 16:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:03 INFO - 'LOGNAME': 'cltbld', 16:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:03 INFO - 'MOZ_NO_REMOTE': '1', 16:16:03 INFO - 'NO_EM_RESTART': '1', 16:16:03 INFO - 'PAGER': '/bin/cat', 16:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:03 INFO - 'PWD': '/builds/slave/test', 16:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:03 INFO - 'SHELL': '/bin/bash', 16:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:03 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:03 INFO - 'USER': 'cltbld', 16:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:03 INFO - 'XPC_FLAGS': '0x0', 16:16:03 INFO - 'XPC_SERVICE_NAME': '0', 16:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:04 INFO - Downloading/unpacking psutil>=3.1.1 16: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 16: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 16: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 16: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 16: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 16: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 16:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:07 INFO - Installing collected packages: psutil 16:16:07 INFO - Running setup.py install for psutil 16:16:08 INFO - building 'psutil._psutil_osx' extension 16:16:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:16:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:16:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:16:08 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 16:16:08 INFO - building 'psutil._psutil_posix' extension 16:16:08 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 16:16:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:16:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:16:08 INFO - ^ 16:16:08 INFO - 1 warning generated. 16:16:08 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 16:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:08 INFO - Successfully installed psutil 16:16:08 INFO - Cleaning up... 16:16:08 INFO - Return code: 0 16:16:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:08 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:08 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 16:16:08 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 16:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:08 INFO - 'HOME': '/Users/cltbld', 16:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:08 INFO - 'LOGNAME': 'cltbld', 16:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:08 INFO - 'MOZ_NO_REMOTE': '1', 16:16:08 INFO - 'NO_EM_RESTART': '1', 16:16:08 INFO - 'PAGER': '/bin/cat', 16:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:08 INFO - 'PWD': '/builds/slave/test', 16:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:08 INFO - 'SHELL': '/bin/bash', 16:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:08 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:08 INFO - 'USER': 'cltbld', 16:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:08 INFO - 'XPC_FLAGS': '0x0', 16:16:08 INFO - 'XPC_SERVICE_NAME': '0', 16:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:11 INFO - Installing collected packages: mozsystemmonitor 16:16:11 INFO - Running setup.py install for mozsystemmonitor 16:16:11 INFO - Successfully installed mozsystemmonitor 16:16:11 INFO - Cleaning up... 16:16:12 INFO - Return code: 0 16:16:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:12 INFO - 'HOME': '/Users/cltbld', 16:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:12 INFO - 'LOGNAME': 'cltbld', 16:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:12 INFO - 'MOZ_NO_REMOTE': '1', 16:16:12 INFO - 'NO_EM_RESTART': '1', 16:16:12 INFO - 'PAGER': '/bin/cat', 16:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:12 INFO - 'PWD': '/builds/slave/test', 16:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:12 INFO - 'SHELL': '/bin/bash', 16:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:12 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:12 INFO - 'USER': 'cltbld', 16:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:12 INFO - 'XPC_FLAGS': '0x0', 16:16:12 INFO - 'XPC_SERVICE_NAME': '0', 16:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:14 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 16:16:14 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 16:16:14 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 16:16:14 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 16:16:14 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 16:16:14 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 16:16:15 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:15 INFO - warning: no files found matching '*.txt' 16:16:15 INFO - no previously-included directories found matching 'build' 16:16:15 INFO - no previously-included directories found matching 'dist' 16:16:15 INFO - no previously-included directories found matching '.git*' 16:16:15 INFO - Installing collected packages: jsonschema, functools32 16:16:15 INFO - Running setup.py install for functools32 16:16:15 INFO - warning: no files found matching '*.txt' 16:16:15 INFO - no previously-included directories found matching 'build' 16:16:15 INFO - no previously-included directories found matching 'dist' 16:16:15 INFO - no previously-included directories found matching '.git*' 16:16:15 INFO - Successfully installed jsonschema functools32 16:16:15 INFO - Cleaning up... 16:16:15 INFO - Return code: 0 16:16:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:16:15 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')]} 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 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')]} 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:15 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 16:16:15 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 16:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:15 INFO - 'HOME': '/Users/cltbld', 16:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:15 INFO - 'LOGNAME': 'cltbld', 16:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:15 INFO - 'MOZ_NO_REMOTE': '1', 16:16:15 INFO - 'NO_EM_RESTART': '1', 16:16:15 INFO - 'PAGER': '/bin/cat', 16:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:15 INFO - 'PWD': '/builds/slave/test', 16:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:15 INFO - 'SHELL': '/bin/bash', 16:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:15 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:15 INFO - 'USER': 'cltbld', 16:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:15 INFO - 'XPC_FLAGS': '0x0', 16:16:15 INFO - 'XPC_SERVICE_NAME': '0', 16:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:16:15 INFO - Cleaning up... 16:16:15 INFO - Return code: 0 16:16:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:15 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')]} 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 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')]} 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:15 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 16:16:15 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 16:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:15 INFO - 'HOME': '/Users/cltbld', 16:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:15 INFO - 'LOGNAME': 'cltbld', 16:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:15 INFO - 'MOZ_NO_REMOTE': '1', 16:16:15 INFO - 'NO_EM_RESTART': '1', 16:16:15 INFO - 'PAGER': '/bin/cat', 16:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:15 INFO - 'PWD': '/builds/slave/test', 16:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:15 INFO - 'SHELL': '/bin/bash', 16:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:15 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:15 INFO - 'USER': 'cltbld', 16:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:15 INFO - 'XPC_FLAGS': '0x0', 16:16:15 INFO - 'XPC_SERVICE_NAME': '0', 16:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:18 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 16:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16: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 16: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 16: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 16: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 16: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 16: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 16:16:20 INFO - Downloading docopt-0.6.1.tar.gz 16:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:20 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:20 INFO - Running setup.py install for blobuploader 16:16:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:20 INFO - Running setup.py install for requests 16:16:20 INFO - Running setup.py install for docopt 16:16:20 INFO - Successfully installed blobuploader requests docopt 16:16:20 INFO - Cleaning up... 16:16:21 INFO - Return code: 0 16:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:21 INFO - 'HOME': '/Users/cltbld', 16:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:21 INFO - 'LOGNAME': 'cltbld', 16:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:21 INFO - 'MOZ_NO_REMOTE': '1', 16:16:21 INFO - 'NO_EM_RESTART': '1', 16:16:21 INFO - 'PAGER': '/bin/cat', 16:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:21 INFO - 'PWD': '/builds/slave/test', 16:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:21 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - 'XPC_FLAGS': '0x0', 16:16:21 INFO - 'XPC_SERVICE_NAME': '0', 16:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Msveyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-FEqOiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-i82GSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-xgewhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-27MuFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-g6EbDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:21 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-51euwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ljI6hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-2FpkfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-mbu8nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-YVYciZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-PWufxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-9HtUb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-FYTHgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-_H8mWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-yhvIRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:22 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ZizjPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:23 INFO - Running setup.py install for manifestparser 16:16:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozcrash 16:16:23 INFO - Running setup.py install for mozdebug 16:16:23 INFO - Running setup.py install for mozdevice 16:16:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozfile 16:16:23 INFO - Running setup.py install for mozhttpd 16:16:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozinfo 16:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozInstall 16:16:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozleak 16:16:24 INFO - Running setup.py install for mozlog 16:16:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for moznetwork 16:16:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozprocess 16:16:24 INFO - Running setup.py install for mozprofile 16:16:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Running setup.py install for mozrunner 16:16:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Running setup.py install for mozscreenshot 16:16:25 INFO - Running setup.py install for moztest 16:16:25 INFO - Running setup.py install for mozversion 16:16:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:25 INFO - Cleaning up... 16:16:25 INFO - Return code: 0 16:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:25 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')]} 16:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 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')]} 16:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:25 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 16:16:25 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 16:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:25 INFO - 'HOME': '/Users/cltbld', 16:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:25 INFO - 'LOGNAME': 'cltbld', 16:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:25 INFO - 'MOZ_NO_REMOTE': '1', 16:16:25 INFO - 'NO_EM_RESTART': '1', 16:16:25 INFO - 'PAGER': '/bin/cat', 16:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:25 INFO - 'PWD': '/builds/slave/test', 16:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:25 INFO - 'SHELL': '/bin/bash', 16:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:25 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:25 INFO - 'USER': 'cltbld', 16:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:25 INFO - 'XPC_FLAGS': '0x0', 16:16:25 INFO - 'XPC_SERVICE_NAME': '0', 16:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-X5XUW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-g9WU1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-LWjaBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-HQQNys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Kot9HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-oa1ccf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-D2V3Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-RyxycC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-_XEiVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:26 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-e01cVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-X_4spk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-yqc3pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-j0zqXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-fZ78Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-BECoGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-7gKcC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:27 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-dB9bgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:30 INFO - Downloading blessings-1.6.tar.gz 16:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:30 INFO - Installing collected packages: blessings 16:16:30 INFO - Running setup.py install for blessings 16:16:30 INFO - Successfully installed blessings 16:16:30 INFO - Cleaning up... 16:16:30 INFO - Return code: 0 16:16:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:30 INFO - Reading from file tmpfile_stdout 16:16:30 INFO - Current package versions: 16:16:30 INFO - blessings == 1.6 16:16:30 INFO - blobuploader == 1.2.4 16:16:30 INFO - docopt == 0.6.1 16:16:30 INFO - functools32 == 3.2.3-2 16:16:30 INFO - jsonschema == 2.5.1 16:16:30 INFO - manifestparser == 1.1 16:16:30 INFO - mozInstall == 1.12 16:16:30 INFO - mozcrash == 0.17 16:16:30 INFO - mozdebug == 0.1 16:16:30 INFO - mozdevice == 0.48 16:16:30 INFO - mozfile == 1.2 16:16:30 INFO - mozhttpd == 0.7 16:16:30 INFO - mozinfo == 0.9 16:16:30 INFO - mozleak == 0.1 16:16:30 INFO - mozlog == 3.4 16:16:30 INFO - moznetwork == 0.27 16:16:30 INFO - mozprocess == 0.23 16:16:30 INFO - mozprofile == 0.28 16:16:30 INFO - mozrunner == 6.12 16:16:30 INFO - mozscreenshot == 0.1 16:16:30 INFO - mozsystemmonitor == 0.3 16:16:30 INFO - moztest == 0.7 16:16:30 INFO - mozversion == 1.4 16:16:30 INFO - psutil == 3.1.1 16:16:30 INFO - requests == 1.2.3 16:16:30 INFO - wsgiref == 0.1.2 16:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:30 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:30 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 16:16:30 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 16:16:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:30 INFO - 'HOME': '/Users/cltbld', 16:16:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:30 INFO - 'LOGNAME': 'cltbld', 16:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:30 INFO - 'MOZ_NO_REMOTE': '1', 16:16:30 INFO - 'NO_EM_RESTART': '1', 16:16:30 INFO - 'PAGER': '/bin/cat', 16:16:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:30 INFO - 'PWD': '/builds/slave/test', 16:16:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:30 INFO - 'SHELL': '/bin/bash', 16:16:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:30 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:30 INFO - 'USER': 'cltbld', 16:16:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:30 INFO - 'XPC_FLAGS': '0x0', 16:16:30 INFO - 'XPC_SERVICE_NAME': '0', 16:16:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 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 0x104a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033ca7bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 16:16:31 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 16:16:31 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 16:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:31 INFO - 'HOME': '/Users/cltbld', 16:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:31 INFO - 'LOGNAME': 'cltbld', 16:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:31 INFO - 'MOZ_NO_REMOTE': '1', 16:16:31 INFO - 'NO_EM_RESTART': '1', 16:16:31 INFO - 'PAGER': '/bin/cat', 16:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:31 INFO - 'PWD': '/builds/slave/test', 16:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:31 INFO - 'SHELL': '/bin/bash', 16:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:16:31 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:31 INFO - 'USER': 'cltbld', 16:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:31 INFO - 'XPC_FLAGS': '0x0', 16:16:31 INFO - 'XPC_SERVICE_NAME': '0', 16:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Running post-action listener: _resource_record_post_action 16:16:31 INFO - Running post-action listener: _start_resource_monitoring 16:16:31 INFO - Starting resource monitoring. 16:16:31 INFO - [mozharness: 2016-11-05 23:16:31.517781Z] Finished create-virtualenv step (success) 16:16:31 INFO - [mozharness: 2016-11-05 23:16:31.518760Z] Running install step. 16:16:31 INFO - Running pre-action listener: _resource_record_pre_action 16:16:31 INFO - Running main action method: install 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Output received: 16:16:31 INFO - Usage: mozinstall [options] installer 16:16:31 INFO - Options: 16:16:31 INFO - -h, --help show this help message and exit 16:16:31 INFO - -d DEST, --destination=DEST 16:16:31 INFO - Directory to install application into. [default: 16:16:31 INFO - "/builds/slave/test"] 16:16:31 INFO - --app=APP Application being installed. [default: firefox] 16:16:31 INFO - mkdir: /builds/slave/test/build/application 16:16:31 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'] 16:16:31 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 16:17:04 INFO - Reading from file tmpfile_stdout 16:17:04 INFO - Output received: 16:17:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:17:04 INFO - Running post-action listener: _resource_record_post_action 16:17:04 INFO - [mozharness: 2016-11-05 23:17:04.252449Z] Finished install step (success) 16:17:04 INFO - [mozharness: 2016-11-05 23:17:04.252615Z] Running run-tests step. 16:17:04 INFO - Running pre-action listener: _resource_record_pre_action 16:17:04 INFO - Running main action method: run_tests 16:17:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:04 INFO - 2016-11-05 16:17:04.267 screenresolution[2286:26104] starting screenresolution argv=screenresolution get 16:17:04 INFO - 2016-11-05 16:17:04.269 screenresolution[2286:26104] Display 0: 1600x1200x32@60 16:17:04 INFO - 2016-11-05 16:17:04.275 screenresolution[2287:26106] starting screenresolution argv=screenresolution list 16:17:04 INFO - Available Modes on Display 0 16:17:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:04 INFO - Intel Iris: 16:17:04 INFO - Chipset Model: Intel Iris 16:17:04 INFO - Type: GPU 16:17:04 INFO - Bus: Built-In 16:17:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:04 INFO - Vendor: Intel (0x8086) 16:17:04 INFO - Device ID: 0x0a2e 16:17:04 INFO - Revision ID: 0x0009 16:17:04 INFO - Displays: 16:17:04 INFO - Display: 16:17:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:04 INFO - Display Serial Number: 1600x1200 60 16:17:04 INFO - Main Display: Yes 16:17:04 INFO - Mirror: Off 16:17:04 INFO - Online: Yes 16:17:04 INFO - Rotation: Supported 16:17:04 INFO - Return code: 0 16:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:04 INFO - Python 2.7.3 16:17:04 INFO - Return code: 0 16:17:04 INFO - grabbing minidump binary from tooltool 16:17: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')]} 16:17:04 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 0x104820d30>, '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 0x104686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:04 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 16:17:04 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 16:17:04 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 16:17:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:04 INFO - Return code: 0 16:17:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:04 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/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 16:17:04 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/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0388 --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 16:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6zq5EvuY6o/Render', 16:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:04 INFO - 'HOME': '/Users/cltbld', 16:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:04 INFO - 'LOGNAME': 'cltbld', 16:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:04 INFO - 'MOZ_NO_REMOTE': '1', 16:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:04 INFO - 'NO_EM_RESTART': '1', 16:17:04 INFO - 'PAGER': '/bin/cat', 16:17:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:04 INFO - 'PWD': '/builds/slave/test', 16:17:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:04 INFO - 'SHELL': '/bin/bash', 16:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sUWoUqeBp2/Listeners', 16:17:04 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 16:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:04 INFO - 'USER': 'cltbld', 16:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:04 INFO - 'XPC_FLAGS': '0x0', 16:17:04 INFO - 'XPC_SERVICE_NAME': '0', 16:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:04 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/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 16:17:04 INFO - mozversion application_buildid: 20161105060620 16:17:04 INFO - mozversion application_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:04 INFO - mozversion application_name: Firefox 16:17:04 INFO - mozversion application_remotingname: firefox-dev 16:17:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:04 INFO - mozversion application_vendor: Mozilla 16:17:04 INFO - mozversion application_version: 51.0a2 16:17:04 INFO - mozversion platform_buildid: 20161105060620 16:17:04 INFO - mozversion platform_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:04 INFO - mozversion platform_version: 51.0a2 16:17:04 INFO - using testdate: 1478387824 16:17:04 INFO - actual date: 1478387824 16:17:04 INFO - starting webserver on 'localhost:53317' 16:17:04 INFO - SUITE-START | Running 2 tests 16:17:04 INFO - TEST-START | dromaeo_css 16:17:04 INFO - operating with platform_type : mac_ 16:17:04 INFO - Initialising browser for dromaeo_css test... 16:17:04 INFO - TEST-INFO | started process 2297 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpSQrL4y/profile http://localhost:53317/getInfo.html) 16:17:07 INFO - PROCESS | 2297 | __metrics Screen width/height:1600/1200 16:17:07 INFO - PROCESS | 2297 | colorDepth:24 16:17:07 INFO - PROCESS | 2297 | Browser inner width/height: 1024/689 16:17:07 INFO - PROCESS | 2297 | __metrics 16:17:07 INFO - PROCESS | 2297 | 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" 16:17:07 INFO - PROCESS | 2297 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:17:08 INFO - TEST-INFO | 2297: exit 0 16:17:08 INFO - Browser initialized. 16:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:08 INFO - TEST-INFO | started process 2299 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpSQrL4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:20 INFO - PROCESS | 2299 | RSS: Main: 219795456 16:17:20 INFO - PROCESS | 2299 | 16:18:11 INFO - PROCESS | 2299 | 1478387891587 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] 16:20:23 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53317/tests/dromaeo/cssquery-ext.html) 16:20:25 INFO - PROCESS | 2299 | RSS: Main: 364744704 16:20:25 INFO - PROCESS | 2299 | 16:23:28 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-ext.html (next: http://localhost:53317/tests/dromaeo/cssquery-jquery.html) 16:23:28 INFO - PROCESS | 2299 | RSS: Main: 351576064 16:23:28 INFO - PROCESS | 2299 | 16:26:31 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53317/tests/dromaeo/cssquery-mootools.html) 16:26:31 INFO - PROCESS | 2299 | RSS: Main: 311869440 16:26:31 INFO - PROCESS | 2299 | 16:29:33 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53317/tests/dromaeo/cssquery-prototype.html) 16:29:34 INFO - PROCESS | 2299 | RSS: Main: 320901120 16:29:34 INFO - PROCESS | 2299 | 16:32:38 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53317/tests/dromaeo/cssquery-yui.html) 16:32:38 INFO - PROCESS | 2299 | RSS: Main: 310136832 16:32:38 INFO - PROCESS | 2299 | 16:35:41 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:53317/tests/dromaeo/cssquery-yui.html (next: http://localhost:53317/tests/dromaeo/cssquery-dojo.html) 16:35:42 INFO - PROCESS | 2299 | RSS: Main: 371183616 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | __start_tp_report 16:35:42 INFO - PROCESS | 2299 | _x_x_mozilla_page_load 16:35:42 INFO - PROCESS | 2299 | _x_x_mozilla_page_load_details 16:35:42 INFO - PROCESS | 2299 | |i|pagename|runs| 16:35:42 INFO - PROCESS | 2299 | |0;dojo.html;2747.381839086205;3285.3922024425474;3333.949990750139;3350.798952062878;3375.240570871554;5600.6079574429805;5729.341125770532;5740.655560666363;5770.134479828028;5789.2184555085105;5714.485696287334;5800.216970708963;5811.215485909401;5816.621919575225;5818.912716309259;5230.058589453897;5234.6859188448625;5236.162214045763;5270.92093618596;5302.098643230641;5182.922256166161;5199.714015729133;5316.76074576645;5362.785488580452;5386.946130538703;5225.686458812484;5259.027079990195;5284.180951952434;5317.12267475868;5322.121849894782;5238.816641417551;5241;5241.973790131063;5290.074237008508;5296.655717378397;5158.561522270612;5251.737413129366;5257.789688412459;5279;5311.920321195185;5575.972120139414;5629.549636029149;5648.9152662709685;5677.858053548694;5765.336986246593;6170.167027451282;6175.783847565359;6202.038684003986;6207.720652570645;6217.409346112112;6109.205803245594;6198.442140207403;6199.442050215457;6202.19371481709;6204.317525072239;5702.258706368146;5708.086706127;5736.5410767139365;5871.442212989759;5913.7930172444185;6203.131561581382;6215.689215539295;6267.185265915402;6267.2165979252595;6321.841953951188;6105.297890742532;6176.444120029129;6194.721237544321;6198;6206.286277078104;6211.81364559064;6240.375962403723;6261.279952805486;6261.78083767066;6267.091271765568;6082.118092876508;6116.427075091891;6134;6139.8686669797835;6185.690715464209;5130.79476820923;6299.5275354348605;6305.8108256752375;6307.274663413675;6315.084312774714;4902.019596080798;4939.48135445773;4943.629227807929;4968.925466118011;4995.725235112103;4376.081022985145;4402.4056752338665;4488.506264310923;4490.50604433512;4513.616342610849;5685.857853553694;5717.171010203498;5717.885642287131;5736.483716465538;5835.708214589254;6298.496120310456;6335.239771227482;6339.904901426482;6345.650989195638;6354.26925903527;5759.971200144057;5781.768729250783;5786.045302525036;5795.681237531892;5833.562482813806;5269.4730526947;5329.786808527616;5366.060939335601;5366.436524164907;5410.729463526808;6280.183576135165;6283.717232724447;6320.778772742932;6325.209348831396;6328;6316.399942005502;6334.081558174131;6340.556161068681;6352.936470635234;6411.5832470889245;5750.453706897838;5871.324797648325;6258.718357674006;6269.090981807703;6323.968380158254;6156.015037593964;6251.156093927443;6266.37336266388;6275.309715931336;6277.18396608438;6109.816705498843;6132.264128304453;6328.208973878265;6343.238811342669;6351.682415879095;5965.6718880461995;6028.1861948638125;6146.969265153645;6164.198654174928;6168.599041062316;6035.0343944970355;6114.755409783559;6132.141500190066;6137.009281402767;6188.257409110935;6040.36576159497;6052.364501727256;6055.909161362495;6069.05929580898;6084.117802918464;5418.566514678738;6130.754769809158;6168.167297414791;6188.319284878749;6211.472024877936;5760.740766665594;5819.4180581943165;5834.03738383162;5876.147958545901;5891.558133139946 16:35:42 INFO - PROCESS | 2299 | |1;ext.html;446.72972851424885;464.5238630403836;494.8589651949195;513.8869448721282;532.409025981161;30550.84724576377;32091.03726888191;33602.327953440945;42925;42939.92650183747;43609;44343;44589.88525286869;44592;44655.55344446554;9789.755256118582;9980.451075190862;9988.950055249714;9991.550380232871;10004.699859004206;9881.604735810559;9958.502074896227;9977.50112494376;9978.650747223848;9979.401235925832;9942.403455792639;9997.400155990628;9999.150072243869;10013.799724005516;10021.34861234021;9919.256055795808;9947.452890091043;9960.203183745283;9980.95009524955;10007.149392301699;8473.618687159093;8496.405251632388;9878.407295562218;9965.252606054502;9966.053224943691;41407.58592414098;41804.372934406005;41845.37231941523;41899.7905010476;41962.79018604918;3404.7616666833333;3452.102453362119;3469.115375579211;3754.755940863835;3853.7495062820826;30269.091927241996;31451.370972580648;32022.35955280881;32775.836120819244;33512.83243583791;3216.260260140181;3232.2565809863627;3287.6547962464074;3369.444041733111;3426.9828650856834;546103;550797;553931;554403;555790;55556;61953.69023154856;64013;64075.679621601594;64110.717785644956;35576.82211588977;35826.820865895505;36246.45630315547;36373.45439818405;37188;17516.12419379026;17688.204030818644;17718.734218986727;17720.645587088446;17728.379506717203;13161.53934612303;13265.336733163304;13272.336383180802;13280.136791108547;13281.203127812361;19606.21575137007;19790.802091979185;19836;19843.603127937648;19870.304539341054;6391.296957334689;7453.627318634047;7584.2794934481135;7633.351165150913;7646.617669116522;726.8582626387804;997.8253805583994;1008.6873069348526;1016.0973303809151;1036.9481525923673;30415.78336866545;30934.381312374077;31214.75400035858;31538.684613154033;31539.21151971173;865.6796985115421;1081.751197224627;1082.2910993299402;1127.763169734365;1195.6114262864603;15765.605859853595;15851.445199417965;16098.517044488684;16963.830361696473;16981.745273820903;719501;719869;721787;733047;742214;60943.69528152331;61615.69192154011;61719;61746;61835.07247391293;1254.9309787961568;1274.1972557289034;1382.3019375215451;1384.3424373422545;1412.1174266083697;30344.696553034188;31269.530957036117;32266.83866580652;32327.35345293034;32911.177220569676;52774.73612631912;53281;53444.73277633587;53449.46550534445;53470.465295348105;604757;609642;610052;610412;611800;28606.856965715036;29285.267868303465;29341.26646833761;29385.559216611342;29419.264518387212;48863.755681221366;49098.77253068702;49113.508864910895;49734;49831.00337993147;39067.41398879076;39156.41265381079;40565.39151912665;41917.79041104775;41955.37066944059;39832.80083599564;39967.60032399639;40445.797771010955;41816.790916045225;42167.36748948829;38836.029099272746;39416;39550.80224598858;39615.40576891407;39626.80186599164;32745.017649470556;34852.47721284132;35019;35030.47454288239;35358.646413535535;26501.80741866659;26598.601020985087;26635.733642663326;26652;26883.193504194904 16:35:42 INFO - PROCESS | 2299 | |2;jquery.html;349.3955457059289;371.9088823238306;373.41746874875196;382.48746679449533;398.39642940944475;14834.48079317224;15094.924525377372;15974.760378594316;20619.07214175362;21074.683879741777;16515.66968660626;19892.801071989277;21042.36872893812;21059.84170870605;21314.36056918291;5247.029299579571;5912.4974377178;6045.395460453963;6171.413715697002;6174.5060395168275;5373.516383525482;6103.26760788706;6158.538109641772;6162.198914141155;6220.813375598739;4885.951140488585;5813.331466881299;6026.668533230692;6084.6349219047;6116.8470788230425;5970.940290597104;6038.426349496791;6044.697765111749;6050.757969681207;6065.090236464565;5057.165567681365;5195;5252.422233554306;5325.840224793263;5326.627136100475;26367;26421.33946651349;26461.73538264612;26578.33554161142;26839.92640294386;2221.278084622504;2295.885205739723;2329.7670232976734;2386.7016622922133;2474.2453551666736;15549.844501555066;15928.203589820463;15959.840401595951;16190.352385904549;16669.583260418585;1484.5768955847532;1837.6324735052908;1848.7504186934725;1850.6206227723285;1868.26203649559;113299.43350283278;114984;115435.42282288535;116612.83387166105;118152;10685.358878467317;10763.300385474919;10860.348379097279;10867.29362591429;11203.271787333797;14004.089734167246;14031.158130512202;14034.157950523002;14040.578782636538;14060.226687532284;7769;8800.19595982822;8902.643894244287;8905.599248033854;9026.232770214474;8699.739007829776;9051.728448146567;9061.184493395625;9061.54692265384;9228.630854765734;6686.465082793365;6772.356626120511;6777;6801.741677789526;6862.210845752703;1830.2678928428736;1872.3633964452151;1873.7938826729048;1877.0896115384028;1913.579012617222;708.3684113518304;802.8635132027453;878.9560521973875;958.018031517686;959.5442164971582;20441.38675839727;21990.120395184334;22694.092236310364;22791.430214244447;22821.31536053921;862.7627402464373;898.5686870302292;973.6835528453281;989.6833013435776;998.83019886618;11395.829062564067;11723.648290551297;11993.700157496132;12010.939945300217;12027.939860300643;521095;570439;595448;613281;613677;121068;121334.39332803279;122905.38547307385;127339;129467.35266323797;972.4214092614742;978.3738407419257;1004.7990401919645;1005.1255407795265;1006.5068116622803;19257.903710481358;19802;19852.404427866608;19919.60160796805;19968;48491;49743;51148;51298;51628;65953;66038.66980665067;66837;69359;71324.64337678278;8102.230288122854;8107.310878575151;8210.958945205475;8321.791955201168;8360.958195209229;13110.803337950128;13309.201447913156;13367.799483007568;13745.862541374858;13747.656308592364;11517.366544840113;11819.231749936227;11990;12060.698482538006;12122.393880305774;11166.832497512707;11267.436628168723;11351.432428378714;11648.475818588015;11799;10550.155987521133;10962.958518940688;10986.725331866768;10993.945030274797;11060.557577696802;8180.427370084037;8209.71266005687;8305.501669899826;8324.417290789586;8343.332533397192;8483.27892129176;10554.313969591953;10794.406307653155;10968.012878840624;11513 16:35:42 INFO - PROCESS | 2299 | |3;mootools.html;1500.1898974553742;1531.8544738249868;1710.9059001754906;1872.1481725814756;1878.192377277771;8415.537145457005;8967.506787126713;8969.910300896989;8976.326775491847;8977.955110224457;7873.448858579887;8077.394195435351;8089.838203235947;8471.449355791869;8715.694950676712;1975.2494052260156;2050.2721533855492;2397.8561286322874;2423.200343886522;2430.513897220554;2009.457446489447;2413.75862413759;2416.6495858100566;2425.854448733082;2430.7569243075727;2398.2805158452484;2409.301302622246;2413.650020746991;2417.830751847371;2420.515896820634;2364.13708996216;2366.3255972048055;2371.1345358944036;2374.8456350337347;2376.809855211579;2372.110458578033;2408;2410.2166795791263;2410.626352915301;2411.1922505960524;8635.913640863573;8842.071582483812;8846.380753347268;8859.158379953895;8871.556422178865;5219.608529360313;5331.5201631853315;5394.676319420808;5395.406505284415;5409.188621706736;3469.705844394362;3563.8574457021687;3683.889483315505;3687.870924517656;3689.741718079709;1068.0814499530397;1072.4530489450358;1092.3009274064605;1103.420704130338;1103.7020004598794;11616.36110013949;11755.235909665844;11768.2939023658;11774.823377649342;11826.93557579822;4594.977025114853;4690.742009189459;4827.324174615486;4864.756762161877;4866.124097662384;10017.599296028076;10017.649382271586;10018.148457381205;10037;10038.598456061822;5317.30874986257;5343.919841202385;5358.196270559447;5360.115580929103;5364.490373414519;3922.9607703923166;4844.709317440965;4857.247126695297;4872.43966943806;4875.536824001714;3191.5372271020574;3804.6195380462286;3808.6000969898314;3882.6505614494267;3908.687305015592;1169.6198735411026;1171.1216587559331;1178.4166837415535;1180.2505409065134;1185.0756410000213;739.8199871205419;774.5468900693045;846.8602680557763;919.3886065766325;940.1068984464786;5736.340320863071;5768.3654797972185;5789.102689083199;5897.882042359129;5988.4909782668965;901.963921443148;943.8112377524385;950.4867371619248;956.3353469338882;977.7751117243074;3825.9234815304094;3885.669718073939;3960.7029472789654;3964.1873415949663;4048.858289959896;10544.841827372595;10739.946300268604;10804.891951080388;10962.945185274022;10981.12151027916;10859.40273284961;10875.728106797393;10902.727431814268;10911.945440272748;10917.727056823484;6665.733370665119;6763.594184348856;7886.72396466121;8167.469114507419;8337.666493340199;5968.194293770285;5991.951408503582;6033.818985430444;6040.275166979991;6073.969630151821;7952.562609056557;10123.24075694311;10124.59501619927;10129.139023183112;10149.137323327599;9669.903300967182;10076.193904487476;10076.445795481319;10162.339447935861;10193.74515637115;7008.159020917523;7214.026106475559;7410.962945185455;7535.6985720570565;7646.923530764621;8380.53907035119;8421.663133474593;8483.915160848312;8559.914400855912;8590.613422396133;7480.0649918760155;7552.773416797505;7566.924330756622;7674.386049115946;7739.613019349123;7305.196428392979;7387.9261207387235;7394.963025184839;7416.221296763978;7448.8882666758955;6955.269696681776;7079.964600176966;7090.645467726697;7091.858162836817;7093.113360829896;4193.308104162779;4762.880927976828;4885.5358740919555;5001.899962000813;5003.249512572997;4977.904860930589;5016.272640467038;5103.336566246364;5131.409887862795;5205.115130427761 16:35:42 INFO - PROCESS | 2299 | |4;prototype.html;302.5099339070706;303.57954233386755;310.4474036215536;314.87562412846927;317.20856463124505;4309.461317335333;4994.375703037116;5447.482489163528;5507.201455788918;5529.778808847646;4067.572904844993;5157.226416037596;5299.655522391042;5371.973140134303;5532.640378375403;3607.8376473058643;3775.7168212384045;3883.941740873889;4160.479940007499;4209.9579004209945;3712.83292251848;4195.971986863223;4197.412362269285;4198.349255865346;4246.3205887058075;3496.3356962177104;3859.517560304962;4154.688398370119;4172.77049762263;4198.244316023115;4116.994593946406;4138.91722165558;4162.229987452331;4187.350960601112;4195.8741237762915;3098.876044958199;3467.497212904115;3563.2160924596546;3601.4237721964623;3608.6030536640947;4289.828406863721;4851.0166247757725;5036.370453693288;5412.91880621791;5425.3489581250105;4686;4700.741459219742;4717.296921916313;4727.3854398927915;4773.830411549158;5503.422140675211;5693.5196848819605;5749.942500574983;5776.913346299809;5787.652740835563;3290.3748287825474;3391.3217356528794;3772.735908486407;3795.4876091727538;3893.669038131762;5052.736815796051;5852;5970.2238708968425;6028.336882942829;6064.666443345614;3580.230250496156;3726.1057346236707;3955.7341650672083;3957.841686332572;3980.5422376426504;4044.8786536403954;4046.2312160689376;4053.351463765783;4054.3107671695884;4062.045419326456;4608.97695511527;4646.535346465326;4662.860114196579;4690.249560070372;4717.018852082134;5452.454754524595;5777.88444231113;5792.9420705793245;5808.634970781863;5830.650160990354;1187.2460987273143;1293.9611811645666;1371.6982263901925;1381.281733498575;1381.5648070857649;792.3661071143063;851.1105894340305;891.7859713668673;907.3784457646533;919.714509444031;4571.794269257824;4982.875428114254;5146.459621739738;5375.650582712111;5434.70109143993;4892.461829198785;5031.591154476752;5191.662541934762;5531.0873705838085;5847.502962248172;5076.263941728429;5095.929854730548;5210.296609957683;5379.35447746273;5469.288992430958;2515.2202817126386;2755.6830964439346;2902.8983985560403;3054.2975115723507;3085.969140308613;5254.343207099113;5680.545556355564;5998.740264544407;6050.909236361458;6115.4190351916495;5193.5590272571835;5913.363281581796;5969.432903874125;5999.520278238611;6020.608660437058;5531.972340138354;5996.400359963969;6033.728482218223;6055.182550355734;6064.454199122012;5410.702411367412;5588.30146231721;5801.448862358069;5908.940910590839;6022.036474164112;5222.817201397933;5420.972895135499;5940.584159108821;5941.584089113893;5975.850603734768;5288.629795914249;5455.454454554513;5865.237519122486;6089.391060893875;6163.890499710095;3277.4264503712234;3308.354870800171;3897.649211570972;3963.960360396359;3964.702647301406;5369.630744160214;5672.546196304368;5974.790882319098;5986.970065149646;5998.4601385875485;5658.632188907708;5717.399673034438;5738.569607279387;5892.175095486721;5912.408759124053;5412.347949504793;5530.861728456821;5768.798092066758;5796.362400136066;5800.1299805029585;4678.76606169697;5183.481651834786;5238.909043664256;5616.241807356118;5650.689212093374;4943.925841112315;5029.290041385946;5624.3250809903075;5679.614561884101;5818.08003358899;4645.396098507307;4658.878551370658;4956.900861982812;5666.716664166857;5673.815581001261 16:35:42 INFO - PROCESS | 2299 | |5;yui.html;639.6833567384144;702.5152644675173;776.59228904825;788.960551972402;817.7587611654561;15014.47449339272;15686.764698529503;16067.196640168004;16074.59813504663;16105;13519.797203041937;13564;13616.251106189156;13662.590122296322;13678.658033549165;661.0678942690795;684.8048306232724;689.8344397344626;822.2969361196181;849.6346570974479;829.2826704900248;847.5507980770202;848.2111636178382;849.2696281198165;851.2679095977454;893.2407453664366;893.78995935955;897.7665806890191;898.734873212404;898.8831451911242;698.4901022253783;717.2289788477408;720.4992530191466;721.0590179815339;889.6308032166643;538.0664547010933;555.5361273336769;643.7746788623991;662.3641304347784;664.2792570061489;14954.252287385696;14965.102093874293;14969.476068337555;14974;14991.700165996728;13673.863261367358;13959.65100872476;14005;14011.29943502831;14258.572242832732;12279.38603069843;12433.875661243363;12476.625701228977;12870.29213393263;13040.217586944718;3725.366687663077;3814.8855534334016;3891.377379619247;3919.451276821247;3938.6849052075763;121150;121159.97100072568;121232;121237.18144227844;121300.39349803195;8936.285097192209;9780.706578802647;10646.840297395545;10980.835287470694;11210.383428911326;17435.91282043607;20024.299149529696;21896.671549926763;21907.452313692283;21920.342389728332;7815.921840781633;7826.491278066907;7987.121416644164;8114.715984940499;8154.429189956765;4326.372675962031;4331.4152589400655;4382.824687012484;4424.80088396023;4597.3333866589155;3492.7031202348085;3564.429691249388;3635.1820840311248;3636;3636.654517820803;670.2493207607511;675.9797206083825;677.5799004617169;677.7797215904851;686.7424715731601;598.9520838332922;607.9179310793074;624.9125122482765;639.268038096377;652.5464801962685;9041.72836920808;9061.909380906238;9181.265498760084;9234.722958311262;9284.675036373694;545.8089668615953;560.9018421776173;606.75123199488;631.0943795653252;636.3286732497168;4207.158568286294;4286.335617979218;4374.540673229329;4420.160169567772;4420.734755914656;97663.04673906483;160056;168073;175136.1243193776;175616;121361;141348;145379;146268.880589181;148776.2561187209;118362;125415;125735.3713231428;127758.44483110472;128948;8763.737087887373;8765.561721913751;8787.253083487974;8816.471011739317;8873.511956842178;42904.14191716086;53450;58338.7083064582;58722.9446969354;70031;58882.70558647179;67770.66114669395;70257.97420257934;89113;99219.50390248002;12450.750984980068;12611.810822837848;12865.678358041125;12969.481220751064;13457.510360583323;14104.576862694135;14494.492692755703;15329.77005344943;15668.608284792972;15798.289076991334;14034.578962631138;14041;14360.640983975483;14884.404623814926;14919.701605967603;10866.511007004545;13062.477500899857;14165.858341416453;14372.85627143757;14433.7834932474;13562.728745424838;13669.931650341685;13861.584152475441;14367.640808979859;14443.277836108362;10972.23194376386;11237.887621123684;11411.54353825871;11554.306741595532;12087.879121208676;11362.176854492942;11577.015953644035;11639.128089348986;11753.412329383325;11779.175457717878 16:35:42 INFO - PROCESS | 2299 | __end_tp_report 16:35:42 INFO - PROCESS | 2299 | __start_cc_report 16:35:42 INFO - PROCESS | 2299 | _x_x_mozilla_cycle_collect,1419 16:35:42 INFO - PROCESS | 2299 | __end_cc_report 16:35:42 INFO - PROCESS | 2299 | __startTimestamp1478388942031__endTimestamp 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | ------- Summary: start ------- 16:35:42 INFO - PROCESS | 2299 | Number of tests: 6 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#0] dojo.html Cycles:165 Average:5751.16 Median:5891.56 stddev:652.15 (11.1%) stddev-sans-first:610.09 16:35:42 INFO - PROCESS | 2299 | Values: 2747.4 3285.4 3333.9 3350.8 3375.2 5600.6 5729.3 5740.7 5770.1 5789.2 5714.5 5800.2 5811.2 5816.6 5818.9 5230.1 5234.7 5236.2 5270.9 5302.1 5182.9 5199.7 5316.8 5362.8 5386.9 5225.7 5259.0 5284.2 5317.1 5322.1 5238.8 5241.0 5242.0 5290.1 5296.7 5158.6 5251.7 5257.8 5279.0 5311.9 5576.0 5629.5 5648.9 5677.9 5765.3 6170.2 6175.8 6202.0 6207.7 6217.4 6109.2 6198.4 6199.4 6202.2 6204.3 5702.3 5708.1 5736.5 5871.4 5913.8 6203.1 6215.7 6267.2 6267.2 6321.8 6105.3 6176.4 6194.7 6198.0 6206.3 6211.8 6240.4 6261.3 6261.8 6267.1 6082.1 6116.4 6134.0 6139.9 6185.7 5130.8 6299.5 6305.8 6307.3 6315.1 4902.0 4939.5 4943.6 4968.9 4995.7 4376.1 4402.4 4488.5 4490.5 4513.6 5685.9 5717.2 5717.9 5736.5 5835.7 6298.5 6335.2 6339.9 6345.7 6354.3 5760.0 5781.8 5786.0 5795.7 5833.6 5269.5 5329.8 5366.1 5366.4 5410.7 6280.2 6283.7 6320.8 6325.2 6328.0 6316.4 6334.1 6340.6 6352.9 6411.6 5750.5 5871.3 6258.7 6269.1 6324.0 6156.0 6251.2 6266.4 6275.3 6277.2 6109.8 6132.3 6328.2 6343.2 6351.7 5965.7 6028.2 6147.0 6164.2 6168.6 6035.0 6114.8 6132.1 6137.0 6188.3 6040.4 6052.4 6055.9 6069.1 6084.1 5418.6 6130.8 6168.2 6188.3 6211.5 5760.7 5819.4 5834.0 5876.1 5891.6 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#1] ext.html Cycles:180 Average:75397.94 Median:39729.80 stddev:169804.96 (427.4%) stddev-sans-first:170188.06 16:35:42 INFO - PROCESS | 2299 | Values: 446.7 464.5 494.9 513.9 532.4 30550.8 32091.0 33602.3 42925.0 42939.9 43609.0 44343.0 44589.9 44592.0 44655.6 9789.8 9980.5 9989.0 9991.6 10004.7 9881.6 9958.5 9977.5 9978.7 9979.4 9942.4 9997.4 9999.2 10013.8 10021.3 9919.3 9947.5 9960.2 9981.0 10007.1 8473.6 8496.4 9878.4 9965.3 9966.1 41407.6 41804.4 41845.4 41899.8 41962.8 3404.8 3452.1 3469.1 3754.8 3853.7 30269.1 31451.4 32022.4 32775.8 33512.8 3216.3 3232.3 3287.7 3369.4 3427.0 546103.0 550797.0 553931.0 554403.0 555790.0 55556.0 61953.7 64013.0 64075.7 64110.7 35576.8 35826.8 36246.5 36373.5 37188.0 17516.1 17688.2 17718.7 17720.6 17728.4 13161.5 13265.3 13272.3 13280.1 13281.2 19606.2 19790.8 19836.0 19843.6 19870.3 6391.3 7453.6 7584.3 7633.4 7646.6 726.9 997.8 1008.7 1016.1 1036.9 30415.8 30934.4 31214.8 31538.7 31539.2 865.7 1081.8 1082.3 1127.8 1195.6 15765.6 15851.4 16098.5 16963.8 16981.7 719501.0 719869.0 721787.0 733047.0 742214.0 60943.7 61615.7 61719.0 61746.0 61835.1 1254.9 1274.2 1382.3 1384.3 1412.1 30344.7 31269.5 32266.8 32327.4 32911.2 52774.7 53281.0 53444.7 53449.5 53470.5 604757.0 609642.0 610052.0 610412.0 611800.0 28606.9 29285.3 29341.3 29385.6 29419.3 48863.8 49098.8 49113.5 49734.0 49831.0 39067.4 39156.4 40565.4 41917.8 41955.4 39832.8 39967.6 40445.8 41816.8 42167.4 38836.0 39416.0 39550.8 39615.4 39626.8 32745.0 34852.5 35019.0 35030.5 35358.6 26501.8 26598.6 26635.7 26652.0 26883.2 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#2] jquery.html Cycles:180 Average:34368.97 Median:2430.47 stddev:97250.43 (4001.3%) stddev-sans-first:97489.70 16:35:42 INFO - PROCESS | 2299 | Values: 349.4 371.9 373.4 382.5 398.4 14834.5 15094.9 15974.8 20619.1 21074.7 16515.7 19892.8 21042.4 21059.8 21314.4 5247.0 5912.5 6045.4 6171.4 6174.5 5373.5 6103.3 6158.5 6162.2 6220.8 4886.0 5813.3 6026.7 6084.6 6116.8 5970.9 6038.4 6044.7 6050.8 6065.1 5057.2 5195.0 5252.4 5325.8 5326.6 26367.0 26421.3 26461.7 26578.3 26839.9 2221.3 2295.9 2329.8 2386.7 2474.2 15549.8 15928.2 15959.8 16190.4 16669.6 1484.6 1837.6 1848.8 1850.6 1868.3 113299.4 114984.0 115435.4 116612.8 118152.0 10685.4 10763.3 10860.3 10867.3 11203.3 14004.1 14031.2 14034.2 14040.6 14060.2 7769.0 8800.2 8902.6 8905.6 9026.2 8699.7 9051.7 9061.2 9061.5 9228.6 6686.5 6772.4 6777.0 6801.7 6862.2 1830.3 1872.4 1873.8 1877.1 1913.6 708.4 802.9 879.0 958.0 959.5 20441.4 21990.1 22694.1 22791.4 22821.3 862.8 898.6 973.7 989.7 998.8 11395.8 11723.6 11993.7 12010.9 12027.9 521095.0 570439.0 595448.0 613281.0 613677.0 121068.0 121334.4 122905.4 127339.0 129467.4 972.4 978.4 1004.8 1005.1 1006.5 19257.9 19802.0 19852.4 19919.6 19968.0 48491.0 49743.0 51148.0 51298.0 51628.0 65953.0 66038.7 66837.0 69359.0 71324.6 8102.2 8107.3 8211.0 8321.8 8361.0 13110.8 13309.2 13367.8 13745.9 13747.7 11517.4 11819.2 11990.0 12060.7 12122.4 11166.8 11267.4 11351.4 11648.5 11799.0 10550.2 10963.0 10986.7 10993.9 11060.6 8180.4 8209.7 8305.5 8324.4 8343.3 8483.3 10554.3 10794.4 10968.0 11513.0 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#3] mootools.html Cycles:180 Average:5701.64 Median:4861.00 stddev:3207.66 (66.0%) stddev-sans-first:3201.12 16:35:42 INFO - PROCESS | 2299 | Values: 1500.2 1531.9 1710.9 1872.1 1878.2 8415.5 8967.5 8969.9 8976.3 8978.0 7873.4 8077.4 8089.8 8471.4 8715.7 1975.2 2050.3 2397.9 2423.2 2430.5 2009.5 2413.8 2416.6 2425.9 2430.8 2398.3 2409.3 2413.7 2417.8 2420.5 2364.1 2366.3 2371.1 2374.8 2376.8 2372.1 2408.0 2410.2 2410.6 2411.2 8635.9 8842.1 8846.4 8859.2 8871.6 5219.6 5331.5 5394.7 5395.4 5409.2 3469.7 3563.9 3683.9 3687.9 3689.7 1068.1 1072.5 1092.3 1103.4 1103.7 11616.4 11755.2 11768.3 11774.8 11826.9 4595.0 4690.7 4827.3 4864.8 4866.1 10017.6 10017.6 10018.1 10037.0 10038.6 5317.3 5343.9 5358.2 5360.1 5364.5 3923.0 4844.7 4857.2 4872.4 4875.5 3191.5 3804.6 3808.6 3882.7 3908.7 1169.6 1171.1 1178.4 1180.3 1185.1 739.8 774.5 846.9 919.4 940.1 5736.3 5768.4 5789.1 5897.9 5988.5 902.0 943.8 950.5 956.3 977.8 3825.9 3885.7 3960.7 3964.2 4048.9 10544.8 10739.9 10804.9 10962.9 10981.1 10859.4 10875.7 10902.7 10911.9 10917.7 6665.7 6763.6 7886.7 8167.5 8337.7 5968.2 5992.0 6033.8 6040.3 6074.0 7952.6 10123.2 10124.6 10129.1 10149.1 9669.9 10076.2 10076.4 10162.3 10193.7 7008.2 7214.0 7411.0 7535.7 7646.9 8380.5 8421.7 8483.9 8559.9 8590.6 7480.1 7552.8 7566.9 7674.4 7739.6 7305.2 7387.9 7395.0 7416.2 7448.9 6955.3 7080.0 7090.6 7091.9 7093.1 4193.3 4762.9 4885.5 5001.9 5003.2 4977.9 5016.3 5103.3 5131.4 5205.1 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#4] prototype.html Cycles:180 Average:4599.34 Median:5170.35 stddev:1434.90 (27.8%) stddev-sans-first:1402.21 16:35:42 INFO - PROCESS | 2299 | Values: 302.5 303.6 310.4 314.9 317.2 4309.5 4994.4 5447.5 5507.2 5529.8 4067.6 5157.2 5299.7 5372.0 5532.6 3607.8 3775.7 3883.9 4160.5 4210.0 3712.8 4196.0 4197.4 4198.3 4246.3 3496.3 3859.5 4154.7 4172.8 4198.2 4117.0 4138.9 4162.2 4187.4 4195.9 3098.9 3467.5 3563.2 3601.4 3608.6 4289.8 4851.0 5036.4 5412.9 5425.3 4686.0 4700.7 4717.3 4727.4 4773.8 5503.4 5693.5 5749.9 5776.9 5787.7 3290.4 3391.3 3772.7 3795.5 3893.7 5052.7 5852.0 5970.2 6028.3 6064.7 3580.2 3726.1 3955.7 3957.8 3980.5 4044.9 4046.2 4053.4 4054.3 4062.0 4609.0 4646.5 4662.9 4690.2 4717.0 5452.5 5777.9 5792.9 5808.6 5830.7 1187.2 1294.0 1371.7 1381.3 1381.6 792.4 851.1 891.8 907.4 919.7 4571.8 4982.9 5146.5 5375.7 5434.7 4892.5 5031.6 5191.7 5531.1 5847.5 5076.3 5095.9 5210.3 5379.4 5469.3 2515.2 2755.7 2902.9 3054.3 3086.0 5254.3 5680.5 5998.7 6050.9 6115.4 5193.6 5913.4 5969.4 5999.5 6020.6 5532.0 5996.4 6033.7 6055.2 6064.5 5410.7 5588.3 5801.4 5908.9 6022.0 5222.8 5421.0 5940.6 5941.6 5975.9 5288.6 5455.5 5865.2 6089.4 6163.9 3277.4 3308.4 3897.6 3964.0 3964.7 5369.6 5672.5 5974.8 5987.0 5998.5 5658.6 5717.4 5738.6 5892.2 5912.4 5412.3 5530.9 5768.8 5796.4 5800.1 4678.8 5183.5 5238.9 5616.2 5650.7 4943.9 5029.3 5624.3 5679.6 5818.1 4645.4 4658.9 4956.9 5666.7 5673.8 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - PROCESS | 2299 | [#5] yui.html Cycles:180 Average:25542.29 Median:3636.33 stddev:42381.05 (1165.5%) stddev-sans-first:42458.70 16:35:42 INFO - PROCESS | 2299 | Values: 639.7 702.5 776.6 789.0 817.8 15014.5 15686.8 16067.2 16074.6 16105.0 13519.8 13564.0 13616.3 13662.6 13678.7 661.1 684.8 689.8 822.3 849.6 829.3 847.6 848.2 849.3 851.3 893.2 893.8 897.8 898.7 898.9 698.5 717.2 720.5 721.1 889.6 538.1 555.5 643.8 662.4 664.3 14954.3 14965.1 14969.5 14974.0 14991.7 13673.9 13959.7 14005.0 14011.3 14258.6 12279.4 12433.9 12476.6 12870.3 13040.2 3725.4 3814.9 3891.4 3919.5 3938.7 121150.0 121160.0 121232.0 121237.2 121300.4 8936.3 9780.7 10646.8 10980.8 11210.4 17435.9 20024.3 21896.7 21907.5 21920.3 7815.9 7826.5 7987.1 8114.7 8154.4 4326.4 4331.4 4382.8 4424.8 4597.3 3492.7 3564.4 3635.2 3636.0 3636.7 670.2 676.0 677.6 677.8 686.7 599.0 607.9 624.9 639.3 652.5 9041.7 9061.9 9181.3 9234.7 9284.7 545.8 560.9 606.8 631.1 636.3 4207.2 4286.3 4374.5 4420.2 4420.7 97663.0 160056.0 168073.0 175136.1 175616.0 121361.0 141348.0 145379.0 146268.9 148776.3 118362.0 125415.0 125735.4 127758.4 128948.0 8763.7 8765.6 8787.3 8816.5 8873.5 42904.1 53450.0 58338.7 58722.9 70031.0 58882.7 67770.7 70258.0 89113.0 99219.5 12450.8 12611.8 12865.7 12969.5 13457.5 14104.6 14494.5 15329.8 15668.6 15798.3 14034.6 14041.0 14360.6 14884.4 14919.7 10866.5 13062.5 14165.9 14372.9 14433.8 13562.7 13669.9 13861.6 14367.6 14443.3 10972.2 11237.9 11411.5 11554.3 12087.9 11362.2 11577.0 11639.1 11753.4 11779.2 16:35:42 INFO - PROCESS | 2299 | -------- Summary: end -------- 16:35:42 INFO - PROCESS | 2299 | 16:35:42 INFO - TEST-INFO | 2299: exit 0 16:35:42 INFO - TEST-OK | dromaeo_css | took 1117844ms 16:35:42 INFO - TEST-START | kraken 16:35:42 INFO - operating with platform_type : mac_ 16:35:42 INFO - Initialising browser for kraken test... 16:35:42 INFO - TEST-INFO | started process 2302 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpnNuGz6/profile http://localhost:53317/getInfo.html) 16:35:45 INFO - PROCESS | 2302 | __metrics Screen width/height:1600/1200 16:35:45 INFO - PROCESS | 2302 | colorDepth:24 16:35:45 INFO - PROCESS | 2302 | Browser inner width/height: 1024/689 16:35:45 INFO - PROCESS | 2302 | __metrics 16:35:45 INFO - PROCESS | 2302 | 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" 16:35:45 INFO - PROCESS | 2302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:45 INFO - TEST-INFO | 2302: exit 0 16:35:45 INFO - Browser initialized. 16:35:45 INFO - Running cycle 1/1 for kraken test... 16:35:45 INFO - TEST-INFO | started process 2303 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpnNuGz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:58 INFO - PROCESS | 2303 | RSS: Main: 220172288 16:35:58 INFO - PROCESS | 2303 | 16:36:00 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53317/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:01 INFO - PROCESS | 2303 | RSS: Main: 270868480 16:36:01 INFO - PROCESS | 2303 | 16:36:04 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53317/tests/kraken/driver.html?testName=audio-dft) 16:36:04 INFO - PROCESS | 2303 | RSS: Main: 282439680 16:36:04 INFO - PROCESS | 2303 | 16:36:08 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53317/tests/kraken/driver.html?testName=audio-fft) 16:36:08 INFO - PROCESS | 2303 | RSS: Main: 378335232 16:36:08 INFO - PROCESS | 2303 | 16:36:10 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53317/tests/kraken/driver.html?testName=audio-oscillator) 16:36:11 INFO - PROCESS | 2303 | RSS: Main: 281206784 16:36:11 INFO - PROCESS | 2303 | 16:36:13 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53317/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:14 INFO - PROCESS | 2303 | RSS: Main: 282185728 16:36:14 INFO - PROCESS | 2303 | 16:36:16 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53317/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:17 INFO - PROCESS | 2303 | RSS: Main: 317358080 16:36:17 INFO - PROCESS | 2303 | 16:36:20 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53317/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:20 INFO - PROCESS | 2303 | RSS: Main: 318517248 16:36:20 INFO - PROCESS | 2303 | 16:36:23 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53317/tests/kraken/driver.html?testName=json-parse-financial) 16:36:24 INFO - PROCESS | 2303 | RSS: Main: 316506112 16:36:24 INFO - PROCESS | 2303 | 16:36:25 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53317/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:26 INFO - PROCESS | 2303 | RSS: Main: 295907328 16:36:26 INFO - PROCESS | 2303 | 16:36:28 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:29 INFO - PROCESS | 2303 | RSS: Main: 296521728 16:36:29 INFO - PROCESS | 2303 | 16:36:31 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:32 INFO - PROCESS | 2303 | RSS: Main: 298909696 16:36:32 INFO - PROCESS | 2303 | 16:36:35 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:35 INFO - PROCESS | 2303 | RSS: Main: 309026816 16:36:35 INFO - PROCESS | 2303 | 16:36:38 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:39 INFO - PROCESS | 2303 | RSS: Main: 308600832 16:36:39 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53317/tests/kraken/driver.html?testName=ai-astar) 16:36:41 INFO - PROCESS | 2303 | RSS: Main: 352681984 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | __start_tp_report 16:36:41 INFO - PROCESS | 2303 | _x_x_mozilla_page_load 16:36:41 INFO - PROCESS | 2303 | _x_x_mozilla_page_load_details 16:36:41 INFO - PROCESS | 2303 | |i|pagename|runs| 16:36:41 INFO - PROCESS | 2303 | |0;ai-astar;115;113;114;114;113;113;114;113;113;112 16:36:41 INFO - PROCESS | 2303 | |1;audio-beat-detection;150;97;117;179;139;115;108;122;143;110 16:36:41 INFO - PROCESS | 2303 | |2;audio-dft;186;184;186;183;185;184;183;187;186;185 16:36:41 INFO - PROCESS | 2303 | |3;audio-fft;80;82;83;115;84;64;60;58;83;58 16:36:41 INFO - PROCESS | 2303 | |4;audio-oscillator;85;72;94;69;64;69;91;69;72;124 16:36:41 INFO - PROCESS | 2303 | |5;imaging-gaussian-blur;89;86;89;87;88;85;90;86;89;85 16:36:41 INFO - PROCESS | 2303 | |6;imaging-darkroom;94;93;94;93;93;93;94;94;93;94 16:36:41 INFO - PROCESS | 2303 | |7;imaging-desaturate;84;85;85;93;83;85;86;87;87;83 16:36:41 INFO - PROCESS | 2303 | |8;json-parse-financial;55;53;54;54;58;57;57;56;57;57 16:36:41 INFO - PROCESS | 2303 | |9;json-stringify-tinderbox;68;82;74;78;72;70;71;71;71;79 16:36:41 INFO - PROCESS | 2303 | |10;stanford-crypto-aes;83;82;84;89;102;110;84;84;94;103 16:36:41 INFO - PROCESS | 2303 | |11;stanford-crypto-ccm;146;146;141;126;160;155;158;139;193;147 16:36:41 INFO - PROCESS | 2303 | |12;stanford-crypto-pbkdf2;167;164;195;227;211;164;164;165;165;163 16:36:41 INFO - PROCESS | 2303 | |13;stanford-crypto-sha256-iterative;65;67;67;67;67;68;61;59;73;84 16:36:41 INFO - PROCESS | 2303 | __end_tp_report 16:36:41 INFO - PROCESS | 2303 | __start_cc_report 16:36:41 INFO - PROCESS | 2303 | _x_x_mozilla_cycle_collect,1975 16:36:41 INFO - PROCESS | 2303 | __end_cc_report 16:36:41 INFO - PROCESS | 2303 | __startTimestamp1478389001445__endTimestamp 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | ------- Summary: start ------- 16:36:41 INFO - PROCESS | 2303 | Number of tests: 14 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.67 16:36:41 INFO - PROCESS | 2303 | Values: 115.0 113.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 112.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:141.00 stddev:24.59 (17.4%) stddev-sans-first:24.76 16:36:41 INFO - PROCESS | 2303 | Values: 150.0 97.0 117.0 179.0 139.0 115.0 108.0 122.0 143.0 110.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:1.37 (0.7%) stddev-sans-first:1.39 16:36:41 INFO - PROCESS | 2303 | Values: 186.0 184.0 186.0 183.0 185.0 184.0 183.0 187.0 186.0 185.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#3] audio-fft Cycles:10 Average:76.70 Median:81.00 stddev:17.57 (21.7%) stddev-sans-first:18.59 16:36:41 INFO - PROCESS | 2303 | Values: 80.0 82.0 83.0 115.0 84.0 64.0 60.0 58.0 83.0 58.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:72.00 stddev:18.31 (25.4%) stddev-sans-first:19.36 16:36:41 INFO - PROCESS | 2303 | Values: 85.0 72.0 94.0 69.0 64.0 69.0 91.0 69.0 72.0 124.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.50 stddev:1.84 (2.1%) stddev-sans-first:1.86 16:36:41 INFO - PROCESS | 2303 | Values: 89.0 86.0 89.0 87.0 88.0 85.0 90.0 86.0 89.0 85.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:36:41 INFO - PROCESS | 2303 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 94.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:2.90 (3.4%) stddev-sans-first:3.00 16:36:41 INFO - PROCESS | 2303 | Values: 84.0 85.0 85.0 93.0 83.0 85.0 86.0 87.0 87.0 83.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:1.69 (3.0%) stddev-sans-first:1.76 16:36:41 INFO - PROCESS | 2303 | Values: 55.0 53.0 54.0 54.0 58.0 57.0 57.0 56.0 57.0 57.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:73.00 stddev:4.55 (6.2%) stddev-sans-first:4.35 16:36:41 INFO - PROCESS | 2303 | Values: 68.0 82.0 74.0 78.0 72.0 70.0 71.0 71.0 71.0 79.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:84.00 stddev:10.16 (12.1%) stddev-sans-first:10.30 16:36:41 INFO - PROCESS | 2303 | Values: 83.0 82.0 84.0 89.0 102.0 110.0 84.0 84.0 94.0 103.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:151.00 stddev:17.78 (11.8%) stddev-sans-first:18.76 16:36:41 INFO - PROCESS | 2303 | Values: 146.0 146.0 141.0 126.0 160.0 155.0 158.0 139.0 193.0 147.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:166.00 stddev:23.68 (14.3%) stddev-sans-first:24.75 16:36:41 INFO - PROCESS | 2303 | Values: 167.0 164.0 195.0 227.0 211.0 164.0 164.0 165.0 165.0 163.0 16:36:41 INFO - PROCESS | 2303 | 16:36:41 INFO - PROCESS | 2303 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:6.86 (10.2%) stddev-sans-first:7.20 16:36:41 INFO - PROCESS | 2303 | Values: 65.0 67.0 67.0 67.0 67.0 68.0 61.0 59.0 73.0 84.0 16:36:41 INFO - PROCESS | 2303 | -------- Summary: end -------- 16:36:41 INFO - PROCESS | 2303 | 16:36:42 INFO - TEST-INFO | 2303: exit 0 16:36:42 INFO - TEST-OK | kraken | took 59632ms 16:36:42 INFO - SUITE-END | took 1177s 16:36:42 INFO - Completed test suite (00:19:37) 16:36:42 INFO - javascript benchmark 16:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2747.381839086205, 3285.3922024425474, 3333.949990750139, 3350.798952062878, 3375.240570871554, 5600.6079574429805, 5729.341125770532, 5740.655560666363, 5770.134479828028, 5789.2184555085105, 5714.485696287334, 5800.216970708963, 5811.215485909401, 5816.621919575225, 5818.912716309259, 5230.058589453897, 5234.6859188448625, 5236.162214045763, 5270.92093618596, 5302.098643230641, 5182.922256166161, 5199.714015729133, 5316.76074576645, 5362.785488580452, 5386.946130538703, 5225.686458812484, 5259.027079990195, 5284.180951952434, 5317.12267475868, 5322.121849894782, 5238.816641417551, 5241.0, 5241.973790131063, 5290.074237008508, 5296.655717378397, 5158.561522270612, 5251.737413129366, 5257.789688412459, 5279.0, 5311.920321195185, 5575.972120139414, 5629.549636029149, 5648.9152662709685, 5677.858053548694, 5765.336986246593, 6170.167027451282, 6175.783847565359, 6202.038684003986, 6207.720652570645, 6217.409346112112, 6109.205803245594, 6198.442140207403, 6199.442050215457, 6202.19371481709, 6204.317525072239, 5702.258706368146, 5708.086706127, 5736.5410767139365, 5871.442212989759, 5913.7930172444185, 6203.131561581382, 6215.689215539295, 6267.185265915402, 6267.2165979252595, 6321.841953951188, 6105.297890742532, 6176.444120029129, 6194.721237544321, 6198.0, 6206.286277078104, 6211.81364559064, 6240.375962403723, 6261.279952805486, 6261.78083767066, 6267.091271765568, 6082.118092876508, 6116.427075091891, 6134.0, 6139.8686669797835, 6185.690715464209, 5130.79476820923, 6299.5275354348605, 6305.8108256752375, 6307.274663413675, 6315.084312774714, 4902.019596080798, 4939.48135445773, 4943.629227807929, 4968.925466118011, 4995.725235112103, 4376.081022985145, 4402.4056752338665, 4488.506264310923, 4490.50604433512, 4513.616342610849, 5685.857853553694, 5717.171010203498, 5717.885642287131, 5736.483716465538, 5835.708214589254, 6298.496120310456, 6335.239771227482, 6339.904901426482, 6345.650989195638, 6354.26925903527, 5759.971200144057, 5781.768729250783, 5786.045302525036, 5795.681237531892, 5833.562482813806, 5269.4730526947, 5329.786808527616, 5366.060939335601, 5366.436524164907, 5410.729463526808, 6280.183576135165, 6283.717232724447, 6320.778772742932, 6325.209348831396, 6328.0, 6316.399942005502, 6334.081558174131, 6340.556161068681, 6352.936470635234, 6411.5832470889245, 5750.453706897838, 5871.324797648325, 6258.718357674006, 6269.090981807703, 6323.968380158254, 6156.015037593964, 6251.156093927443, 6266.37336266388, 6275.309715931336, 6277.18396608438, 6109.816705498843, 6132.264128304453, 6328.208973878265, 6343.238811342669, 6351.682415879095, 5965.6718880461995, 6028.1861948638125, 6146.969265153645, 6164.198654174928, 6168.599041062316, 6035.0343944970355, 6114.755409783559, 6132.141500190066, 6137.009281402767, 6188.257409110935, 6040.36576159497, 6052.364501727256, 6055.909161362495, 6069.05929580898, 6084.117802918464, 5418.566514678738, 6130.754769809158, 6168.167297414791, 6188.319284878749, 6211.472024877936, 5760.740766665594, 5819.4180581943165, 5834.03738383162, 5876.147958545901, 5891.558133139946], "value": 5707.652297841909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.72972851424885, 464.5238630403836, 494.8589651949195, 513.8869448721282, 532.409025981161, 30550.84724576377, 32091.03726888191, 33602.327953440945, 42925.0, 42939.92650183747, 43609.0, 44343.0, 44589.88525286869, 44592.0, 44655.55344446554, 9789.755256118582, 9980.451075190862, 9988.950055249714, 9991.550380232871, 10004.699859004206, 9881.604735810559, 9958.502074896227, 9977.50112494376, 9978.650747223848, 9979.401235925832, 9942.403455792639, 9997.400155990628, 9999.150072243869, 10013.799724005516, 10021.34861234021, 9919.256055795808, 9947.452890091043, 9960.203183745283, 9980.95009524955, 10007.149392301699, 8473.618687159093, 8496.405251632388, 9878.407295562218, 9965.252606054502, 9966.053224943691, 41407.58592414098, 41804.372934406005, 41845.37231941523, 41899.7905010476, 41962.79018604918, 3404.7616666833333, 3452.102453362119, 3469.115375579211, 3754.755940863835, 3853.7495062820826, 30269.091927241996, 31451.370972580648, 32022.35955280881, 32775.836120819244, 33512.83243583791, 3216.260260140181, 3232.2565809863627, 3287.6547962464074, 3369.444041733111, 3426.9828650856834, 546103.0, 550797.0, 553931.0, 554403.0, 555790.0, 55556.0, 61953.69023154856, 64013.0, 64075.679621601594, 64110.717785644956, 35576.82211588977, 35826.820865895505, 36246.45630315547, 36373.45439818405, 37188.0, 17516.12419379026, 17688.204030818644, 17718.734218986727, 17720.645587088446, 17728.379506717203, 13161.53934612303, 13265.336733163304, 13272.336383180802, 13280.136791108547, 13281.203127812361, 19606.21575137007, 19790.802091979185, 19836.0, 19843.603127937648, 19870.304539341054, 6391.296957334689, 7453.627318634047, 7584.2794934481135, 7633.351165150913, 7646.617669116522, 726.8582626387804, 997.8253805583994, 1008.6873069348526, 1016.0973303809151, 1036.9481525923673, 30415.78336866545, 30934.381312374077, 31214.75400035858, 31538.684613154033, 31539.21151971173, 865.6796985115421, 1081.751197224627, 1082.2910993299402, 1127.763169734365, 1195.6114262864603, 15765.605859853595, 15851.445199417965, 16098.517044488684, 16963.830361696473, 16981.745273820903, 719501.0, 719869.0, 721787.0, 733047.0, 742214.0, 60943.69528152331, 61615.69192154011, 61719.0, 61746.0, 61835.07247391293, 1254.9309787961568, 1274.1972557289034, 1382.3019375215451, 1384.3424373422545, 1412.1174266083697, 30344.696553034188, 31269.530957036117, 32266.83866580652, 32327.35345293034, 32911.177220569676, 52774.73612631912, 53281.0, 53444.73277633587, 53449.46550534445, 53470.465295348105, 604757.0, 609642.0, 610052.0, 610412.0, 611800.0, 28606.856965715036, 29285.267868303465, 29341.26646833761, 29385.559216611342, 29419.264518387212, 48863.755681221366, 49098.77253068702, 49113.508864910895, 49734.0, 49831.00337993147, 39067.41398879076, 39156.41265381079, 40565.39151912665, 41917.79041104775, 41955.37066944059, 39832.80083599564, 39967.60032399639, 40445.797771010955, 41816.790916045225, 42167.36748948829, 38836.029099272746, 39416.0, 39550.80224598858, 39615.40576891407, 39626.80186599164, 32745.017649470556, 34852.47721284132, 35019.0, 35030.47454288239, 35358.646413535535, 26501.80741866659, 26598.601020985087, 26635.733642663326, 26652.0, 26883.193504194904], "value": 20390.686500573396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3955457059289, 371.9088823238306, 373.41746874875196, 382.48746679449533, 398.39642940944475, 14834.48079317224, 15094.924525377372, 15974.760378594316, 20619.07214175362, 21074.683879741777, 16515.66968660626, 19892.801071989277, 21042.36872893812, 21059.84170870605, 21314.36056918291, 5247.029299579571, 5912.4974377178, 6045.395460453963, 6171.413715697002, 6174.5060395168275, 5373.516383525482, 6103.26760788706, 6158.538109641772, 6162.198914141155, 6220.813375598739, 4885.951140488585, 5813.331466881299, 6026.668533230692, 6084.6349219047, 6116.8470788230425, 5970.940290597104, 6038.426349496791, 6044.697765111749, 6050.757969681207, 6065.090236464565, 5057.165567681365, 5195.0, 5252.422233554306, 5325.840224793263, 5326.627136100475, 26367.0, 26421.33946651349, 26461.73538264612, 26578.33554161142, 26839.92640294386, 2221.278084622504, 2295.885205739723, 2329.7670232976734, 2386.7016622922133, 2474.2453551666736, 15549.844501555066, 15928.203589820463, 15959.840401595951, 16190.352385904549, 16669.583260418585, 1484.5768955847532, 1837.6324735052908, 1848.7504186934725, 1850.6206227723285, 1868.26203649559, 113299.43350283278, 114984.0, 115435.42282288535, 116612.83387166105, 118152.0, 10685.358878467317, 10763.300385474919, 10860.348379097279, 10867.29362591429, 11203.271787333797, 14004.089734167246, 14031.158130512202, 14034.157950523002, 14040.578782636538, 14060.226687532284, 7769.0, 8800.19595982822, 8902.643894244287, 8905.599248033854, 9026.232770214474, 8699.739007829776, 9051.728448146567, 9061.184493395625, 9061.54692265384, 9228.630854765734, 6686.465082793365, 6772.356626120511, 6777.0, 6801.741677789526, 6862.210845752703, 1830.2678928428736, 1872.3633964452151, 1873.7938826729048, 1877.0896115384028, 1913.579012617222, 708.3684113518304, 802.8635132027453, 878.9560521973875, 958.018031517686, 959.5442164971582, 20441.38675839727, 21990.120395184334, 22694.092236310364, 22791.430214244447, 22821.31536053921, 862.7627402464373, 898.5686870302292, 973.6835528453281, 989.6833013435776, 998.83019886618, 11395.829062564067, 11723.648290551297, 11993.700157496132, 12010.939945300217, 12027.939860300643, 521095.0, 570439.0, 595448.0, 613281.0, 613677.0, 121068.0, 121334.39332803279, 122905.38547307385, 127339.0, 129467.35266323797, 972.4214092614742, 978.3738407419257, 1004.7990401919645, 1005.1255407795265, 1006.5068116622803, 19257.903710481358, 19802.0, 19852.404427866608, 19919.60160796805, 19968.0, 48491.0, 49743.0, 51148.0, 51298.0, 51628.0, 65953.0, 66038.66980665067, 66837.0, 69359.0, 71324.64337678278, 8102.230288122854, 8107.310878575151, 8210.958945205475, 8321.791955201168, 8360.958195209229, 13110.803337950128, 13309.201447913156, 13367.799483007568, 13745.862541374858, 13747.656308592364, 11517.366544840113, 11819.231749936227, 11990.0, 12060.698482538006, 12122.393880305774, 11166.832497512707, 11267.436628168723, 11351.432428378714, 11648.475818588015, 11799.0, 10550.155987521133, 10962.958518940688, 10986.725331866768, 10993.945030274797, 11060.557577696802, 8180.427370084037, 8209.71266005687, 8305.501669899826, 8324.417290789586, 8343.332533397192, 8483.27892129176, 10554.313969591953, 10794.406307653155, 10968.012878840624, 11513.0], "value": 9745.033438850598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.1898974553742, 1531.8544738249868, 1710.9059001754906, 1872.1481725814756, 1878.192377277771, 8415.537145457005, 8967.506787126713, 8969.910300896989, 8976.326775491847, 8977.955110224457, 7873.448858579887, 8077.394195435351, 8089.838203235947, 8471.449355791869, 8715.694950676712, 1975.2494052260156, 2050.2721533855492, 2397.8561286322874, 2423.200343886522, 2430.513897220554, 2009.457446489447, 2413.75862413759, 2416.6495858100566, 2425.854448733082, 2430.7569243075727, 2398.2805158452484, 2409.301302622246, 2413.650020746991, 2417.830751847371, 2420.515896820634, 2364.13708996216, 2366.3255972048055, 2371.1345358944036, 2374.8456350337347, 2376.809855211579, 2372.110458578033, 2408.0, 2410.2166795791263, 2410.626352915301, 2411.1922505960524, 8635.913640863573, 8842.071582483812, 8846.380753347268, 8859.158379953895, 8871.556422178865, 5219.608529360313, 5331.5201631853315, 5394.676319420808, 5395.406505284415, 5409.188621706736, 3469.705844394362, 3563.8574457021687, 3683.889483315505, 3687.870924517656, 3689.741718079709, 1068.0814499530397, 1072.4530489450358, 1092.3009274064605, 1103.420704130338, 1103.7020004598794, 11616.36110013949, 11755.235909665844, 11768.2939023658, 11774.823377649342, 11826.93557579822, 4594.977025114853, 4690.742009189459, 4827.324174615486, 4864.756762161877, 4866.124097662384, 10017.599296028076, 10017.649382271586, 10018.148457381205, 10037.0, 10038.598456061822, 5317.30874986257, 5343.919841202385, 5358.196270559447, 5360.115580929103, 5364.490373414519, 3922.9607703923166, 4844.709317440965, 4857.247126695297, 4872.43966943806, 4875.536824001714, 3191.5372271020574, 3804.6195380462286, 3808.6000969898314, 3882.6505614494267, 3908.687305015592, 1169.6198735411026, 1171.1216587559331, 1178.4166837415535, 1180.2505409065134, 1185.0756410000213, 739.8199871205419, 774.5468900693045, 846.8602680557763, 919.3886065766325, 940.1068984464786, 5736.340320863071, 5768.3654797972185, 5789.102689083199, 5897.882042359129, 5988.4909782668965, 901.963921443148, 943.8112377524385, 950.4867371619248, 956.3353469338882, 977.7751117243074, 3825.9234815304094, 3885.669718073939, 3960.7029472789654, 3964.1873415949663, 4048.858289959896, 10544.841827372595, 10739.946300268604, 10804.891951080388, 10962.945185274022, 10981.12151027916, 10859.40273284961, 10875.728106797393, 10902.727431814268, 10911.945440272748, 10917.727056823484, 6665.733370665119, 6763.594184348856, 7886.72396466121, 8167.469114507419, 8337.666493340199, 5968.194293770285, 5991.951408503582, 6033.818985430444, 6040.275166979991, 6073.969630151821, 7952.562609056557, 10123.24075694311, 10124.59501619927, 10129.139023183112, 10149.137323327599, 9669.903300967182, 10076.193904487476, 10076.445795481319, 10162.339447935861, 10193.74515637115, 7008.159020917523, 7214.026106475559, 7410.962945185455, 7535.6985720570565, 7646.923530764621, 8380.53907035119, 8421.663133474593, 8483.915160848312, 8559.914400855912, 8590.613422396133, 7480.0649918760155, 7552.773416797505, 7566.924330756622, 7674.386049115946, 7739.613019349123, 7305.196428392979, 7387.9261207387235, 7394.963025184839, 7416.221296763978, 7448.8882666758955, 6955.269696681776, 7079.964600176966, 7090.645467726697, 7091.858162836817, 7093.113360829896, 4193.308104162779, 4762.880927976828, 4885.5358740919555, 5001.899962000813, 5003.249512572997, 4977.904860930589, 5016.272640467038, 5103.336566246364, 5131.409887862795, 5205.115130427761], "value": 4574.6893178922555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5099339070706, 303.57954233386755, 310.4474036215536, 314.87562412846927, 317.20856463124505, 4309.461317335333, 4994.375703037116, 5447.482489163528, 5507.201455788918, 5529.778808847646, 4067.572904844993, 5157.226416037596, 5299.655522391042, 5371.973140134303, 5532.640378375403, 3607.8376473058643, 3775.7168212384045, 3883.941740873889, 4160.479940007499, 4209.9579004209945, 3712.83292251848, 4195.971986863223, 4197.412362269285, 4198.349255865346, 4246.3205887058075, 3496.3356962177104, 3859.517560304962, 4154.688398370119, 4172.77049762263, 4198.244316023115, 4116.994593946406, 4138.91722165558, 4162.229987452331, 4187.350960601112, 4195.8741237762915, 3098.876044958199, 3467.497212904115, 3563.2160924596546, 3601.4237721964623, 3608.6030536640947, 4289.828406863721, 4851.0166247757725, 5036.370453693288, 5412.91880621791, 5425.3489581250105, 4686.0, 4700.741459219742, 4717.296921916313, 4727.3854398927915, 4773.830411549158, 5503.422140675211, 5693.5196848819605, 5749.942500574983, 5776.913346299809, 5787.652740835563, 3290.3748287825474, 3391.3217356528794, 3772.735908486407, 3795.4876091727538, 3893.669038131762, 5052.736815796051, 5852.0, 5970.2238708968425, 6028.336882942829, 6064.666443345614, 3580.230250496156, 3726.1057346236707, 3955.7341650672083, 3957.841686332572, 3980.5422376426504, 4044.8786536403954, 4046.2312160689376, 4053.351463765783, 4054.3107671695884, 4062.045419326456, 4608.97695511527, 4646.535346465326, 4662.860114196579, 4690.249560070372, 4717.018852082134, 5452.454754524595, 5777.88444231113, 5792.9420705793245, 5808.634970781863, 5830.650160990354, 1187.2460987273143, 1293.9611811645666, 1371.6982263901925, 1381.281733498575, 1381.5648070857649, 792.3661071143063, 851.1105894340305, 891.7859713668673, 907.3784457646533, 919.714509444031, 4571.794269257824, 4982.875428114254, 5146.459621739738, 5375.650582712111, 5434.70109143993, 4892.461829198785, 5031.591154476752, 5191.662541934762, 5531.0873705838085, 5847.502962248172, 5076.263941728429, 5095.929854730548, 5210.296609957683, 5379.35447746273, 5469.288992430958, 2515.2202817126386, 2755.6830964439346, 2902.8983985560403, 3054.2975115723507, 3085.969140308613, 5254.343207099113, 5680.545556355564, 5998.740264544407, 6050.909236361458, 6115.4190351916495, 5193.5590272571835, 5913.363281581796, 5969.432903874125, 5999.520278238611, 6020.608660437058, 5531.972340138354, 5996.400359963969, 6033.728482218223, 6055.182550355734, 6064.454199122012, 5410.702411367412, 5588.30146231721, 5801.448862358069, 5908.940910590839, 6022.036474164112, 5222.817201397933, 5420.972895135499, 5940.584159108821, 5941.584089113893, 5975.850603734768, 5288.629795914249, 5455.454454554513, 5865.237519122486, 6089.391060893875, 6163.890499710095, 3277.4264503712234, 3308.354870800171, 3897.649211570972, 3963.960360396359, 3964.702647301406, 5369.630744160214, 5672.546196304368, 5974.790882319098, 5986.970065149646, 5998.4601385875485, 5658.632188907708, 5717.399673034438, 5738.569607279387, 5892.175095486721, 5912.408759124053, 5412.347949504793, 5530.861728456821, 5768.798092066758, 5796.362400136066, 5800.1299805029585, 4678.76606169697, 5183.481651834786, 5238.909043664256, 5616.241807356118, 5650.689212093374, 4943.925841112315, 5029.290041385946, 5624.3250809903075, 5679.614561884101, 5818.08003358899, 4645.396098507307, 4658.878551370658, 4956.900861982812, 5666.716664166857, 5673.815581001261], "value": 4139.512994899552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.6833567384144, 702.5152644675173, 776.59228904825, 788.960551972402, 817.7587611654561, 15014.47449339272, 15686.764698529503, 16067.196640168004, 16074.59813504663, 16105.0, 13519.797203041937, 13564.0, 13616.251106189156, 13662.590122296322, 13678.658033549165, 661.0678942690795, 684.8048306232724, 689.8344397344626, 822.2969361196181, 849.6346570974479, 829.2826704900248, 847.5507980770202, 848.2111636178382, 849.2696281198165, 851.2679095977454, 893.2407453664366, 893.78995935955, 897.7665806890191, 898.734873212404, 898.8831451911242, 698.4901022253783, 717.2289788477408, 720.4992530191466, 721.0590179815339, 889.6308032166643, 538.0664547010933, 555.5361273336769, 643.7746788623991, 662.3641304347784, 664.2792570061489, 14954.252287385696, 14965.102093874293, 14969.476068337555, 14974.0, 14991.700165996728, 13673.863261367358, 13959.65100872476, 14005.0, 14011.29943502831, 14258.572242832732, 12279.38603069843, 12433.875661243363, 12476.625701228977, 12870.29213393263, 13040.217586944718, 3725.366687663077, 3814.8855534334016, 3891.377379619247, 3919.451276821247, 3938.6849052075763, 121150.0, 121159.97100072568, 121232.0, 121237.18144227844, 121300.39349803195, 8936.285097192209, 9780.706578802647, 10646.840297395545, 10980.835287470694, 11210.383428911326, 17435.91282043607, 20024.299149529696, 21896.671549926763, 21907.452313692283, 21920.342389728332, 7815.921840781633, 7826.491278066907, 7987.121416644164, 8114.715984940499, 8154.429189956765, 4326.372675962031, 4331.4152589400655, 4382.824687012484, 4424.80088396023, 4597.3333866589155, 3492.7031202348085, 3564.429691249388, 3635.1820840311248, 3636.0, 3636.654517820803, 670.2493207607511, 675.9797206083825, 677.5799004617169, 677.7797215904851, 686.7424715731601, 598.9520838332922, 607.9179310793074, 624.9125122482765, 639.268038096377, 652.5464801962685, 9041.72836920808, 9061.909380906238, 9181.265498760084, 9234.722958311262, 9284.675036373694, 545.8089668615953, 560.9018421776173, 606.75123199488, 631.0943795653252, 636.3286732497168, 4207.158568286294, 4286.335617979218, 4374.540673229329, 4420.160169567772, 4420.734755914656, 97663.04673906483, 160056.0, 168073.0, 175136.1243193776, 175616.0, 121361.0, 141348.0, 145379.0, 146268.880589181, 148776.2561187209, 118362.0, 125415.0, 125735.3713231428, 127758.44483110472, 128948.0, 8763.737087887373, 8765.561721913751, 8787.253083487974, 8816.471011739317, 8873.511956842178, 42904.14191716086, 53450.0, 58338.7083064582, 58722.9446969354, 70031.0, 58882.70558647179, 67770.66114669395, 70257.97420257934, 89113.0, 99219.50390248002, 12450.750984980068, 12611.810822837848, 12865.678358041125, 12969.481220751064, 13457.510360583323, 14104.576862694135, 14494.492692755703, 15329.77005344943, 15668.608284792972, 15798.289076991334, 14034.578962631138, 14041.0, 14360.640983975483, 14884.404623814926, 14919.701605967603, 10866.511007004545, 13062.477500899857, 14165.858341416453, 14372.85627143757, 14433.7834932474, 13562.728745424838, 13669.931650341685, 13861.584152475441, 14367.640808979859, 14443.277836108362, 10972.23194376386, 11237.887621123684, 11411.54353825871, 11554.306741595532, 12087.879121208676, 11362.176854492942, 11577.015953644035, 11639.128089348986, 11753.412329383325, 11779.175457717878], "value": 7747.561645256146, "unit": "score"}], "name": "dromaeo_css", "value": 7416.50306896713, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 97.0, 117.0, 179.0, 139.0, 115.0, 108.0, 122.0, 143.0, 110.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 186.0, 183.0, 185.0, 184.0, 183.0, 187.0, 186.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 83.0, 115.0, 84.0, 64.0, 60.0, 58.0, 83.0, 58.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 94.0, 69.0, 64.0, 69.0, 91.0, 69.0, 72.0, 124.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 88.0, 85.0, 90.0, 86.0, 89.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 93.0, 83.0, 85.0, 86.0, 87.0, 87.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 58.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 74.0, 78.0, 72.0, 70.0, 71.0, 71.0, 71.0, 79.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 89.0, 102.0, 110.0, 84.0, 84.0, 94.0, 103.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 141.0, 126.0, 160.0, 155.0, 158.0, 139.0, 193.0, 147.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 195.0, 227.0, 211.0, 164.0, 164.0, 165.0, 165.0, 163.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 68.0, 61.0, 59.0, 73.0, 84.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1468.8999999999999, "alertThreshold": 2.0}]} 16:36:42 INFO - Return code: 0 16:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:42 INFO - # TBPL SUCCESS # 16:36:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:42 INFO - 2016-11-05 16:36:42.716 screenresolution[2307:28262] starting screenresolution argv=screenresolution get 16:36:42 INFO - 2016-11-05 16:36:42.718 screenresolution[2307:28262] Display 0: 1600x1200x32@60 16:36:42 INFO - 2016-11-05 16:36:42.724 screenresolution[2308:28265] starting screenresolution argv=screenresolution list 16:36:42 INFO - Available Modes on Display 0 16:36:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:42 INFO - Intel Iris: 16:36:42 INFO - Chipset Model: Intel Iris 16:36:42 INFO - Type: GPU 16:36:42 INFO - Bus: Built-In 16:36:42 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:42 INFO - Vendor: Intel (0x8086) 16:36:42 INFO - Device ID: 0x0a2e 16:36:42 INFO - Revision ID: 0x0009 16:36:42 INFO - Displays: 16:36:42 INFO - Display: 16:36:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:42 INFO - Display Serial Number: 1600x1200 60 16:36:42 INFO - Main Display: Yes 16:36:42 INFO - Mirror: Off 16:36:42 INFO - Online: Yes 16:36:42 INFO - Rotation: Supported 16:36:42 INFO - Return code: 0 16:36:42 INFO - Running post-action listener: _resource_record_post_action 16:36:42 INFO - [mozharness: 2016-11-05 23:36:42.963095Z] Finished run-tests step (success) 16:36:42 INFO - Running post-run listener: _resource_record_post_run 16:36:43 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 1249280; Write bytes: 661602304; Read time: 8; Write time: 1853 16:36:43 INFO - TinderboxPrint: CPU usage
53.2% 16:36:43 INFO - TinderboxPrint: I/O read bytes / time
1,249,280 / 8 16:36:43 INFO - TinderboxPrint: I/O write bytes / time
661,602,304 / 1,853 16:36:43 INFO - TinderboxPrint: CPU idle
2,266.6 (46.8%) 16:36:43 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 16:36:43 INFO - TinderboxPrint: CPU user
1,606.1 (33.2%) 16:36:43 INFO - TinderboxPrint: Swap in / out
364,216,320 / 0 16:36:43 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356348416; Write bytes: 356214784; Read time: 27543; Write time: 721 16:36:43 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 1249280; Write bytes: 295229440; Read time: 8; Write time: 1095 16:36:43 INFO - Running post-run listener: _upload_blobber_files 16:36:43 INFO - Blob upload gear active. 16:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:45 INFO - (blobuploader) - INFO - Done attempting. 16:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:46 INFO - (blobuploader) - INFO - Done attempting. 16:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:48 INFO - (blobuploader) - INFO - Done attempting. 16:36:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:48 INFO - Return code: 0 16:36:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbf7bec84b131406c91f1a9c9380ab86be085999db769f2d3f1267e6388602d4ceff8702bc796f63641ee97afa1db1adaed6dd0e8d0f0ea92b01fac704b1c050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/519b6db9374f7cde90e38ed8368429e0d9946c3dcc45b2b80965ba5f669c852a897ff969bfbc7a31846ea59a06de08d21ca80da42db47ea049d5830527f4272f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43623fbd78837935a02840657a4245645d493664e552660149615819025a1b51adb3eb60839a64cb1fdc4460b6a294d4876b06406d04a422998c58eea6515b0a"} 16:36:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:48 INFO - Contents: 16:36:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbf7bec84b131406c91f1a9c9380ab86be085999db769f2d3f1267e6388602d4ceff8702bc796f63641ee97afa1db1adaed6dd0e8d0f0ea92b01fac704b1c050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/519b6db9374f7cde90e38ed8368429e0d9946c3dcc45b2b80965ba5f669c852a897ff969bfbc7a31846ea59a06de08d21ca80da42db47ea049d5830527f4272f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43623fbd78837935a02840657a4245645d493664e552660149615819025a1b51adb3eb60839a64cb1fdc4460b6a294d4876b06406d04a422998c58eea6515b0a"} 16:36:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:48 INFO - Copying logs to upload dir... 16:36:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.354246 ========= master_lag: 6.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-05 16:36:55.261575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-11-05 16:36:55.265009) ========= 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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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/fbf7bec84b131406c91f1a9c9380ab86be085999db769f2d3f1267e6388602d4ceff8702bc796f63641ee97afa1db1adaed6dd0e8d0f0ea92b01fac704b1c050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/519b6db9374f7cde90e38ed8368429e0d9946c3dcc45b2b80965ba5f669c852a897ff969bfbc7a31846ea59a06de08d21ca80da42db47ea049d5830527f4272f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43623fbd78837935a02840657a4245645d493664e552660149615819025a1b51adb3eb60839a64cb1fdc4460b6a294d4876b06406d04a422998c58eea6515b0a"} build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/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/fbf7bec84b131406c91f1a9c9380ab86be085999db769f2d3f1267e6388602d4ceff8702bc796f63641ee97afa1db1adaed6dd0e8d0f0ea92b01fac704b1c050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/519b6db9374f7cde90e38ed8368429e0d9946c3dcc45b2b80965ba5f669c852a897ff969bfbc7a31846ea59a06de08d21ca80da42db47ea049d5830527f4272f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43623fbd78837935a02840657a4245645d493664e552660149615819025a1b51adb3eb60839a64cb1fdc4460b6a294d4876b06406d04a422998c58eea6515b0a"}' ========= master_lag: 14.86 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-11-05 16:37:10.133992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-05 16:37:10.134311) ========= 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.6zq5EvuY6o/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.sUWoUqeBp2/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.005284 ========= master_lag: 3.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-05 16:37:13.432321) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-11-05 16:37:13.432627) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-11-05 16:37:15.110221) ========= ========= Total master_lag: 24.62 =========