builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1475708990.91 results: success (0) buildid: 20161005135000 builduid: 82443e5d3c9e4715a1b12f9c78dcdadb revision: e666c7433e2fb5bd3f49a1e011170feca4571bd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:50.906767) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:50.907152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:50.907418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:51.007274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:51.007533) ========= 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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-05 16:09:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-10-05 16:09:51 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.606906 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:51.653433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:51.653782) ========= 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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.030463 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:51.707503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 16:09:51.711020) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e666c7433e2fb5bd3f49a1e011170feca4571bd2 --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 e666c7433e2fb5bd3f49a1e011170feca4571bd2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-05 16:09:51,786 truncating revision to first 12 chars 2016-10-05 16:09:51,786 Setting DEBUG logging. 2016-10-05 16:09:51,787 attempt 1/10 2016-10-05 16:09:51,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e666c7433e2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 16:09:52,853 unpacking tar archive at: mozilla-aurora-e666c7433e2f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323888 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 16:09:53.060085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:53.060379) ========= script_repo_revision: e666c7433e2fb5bd3f49a1e011170feca4571bd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:53.060751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:53.061032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 16:09:53.078476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-05 16:09:53.078744) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:09:53 INFO - MultiFileLogger online at 20161005 16:09:53 in /builds/slave/test 16:09:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:09:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:53 INFO - {'append_to_log': False, 16:09:53 INFO - 'base_work_dir': '/builds/slave/test', 16:09:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:09:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:53 INFO - 'branch': 'Mozilla-Aurora', 16:09:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:53 INFO - 'config_files': ('talos/mac_config.py',), 16:09:53 INFO - 'default_actions': ('clobber', 16:09:53 INFO - 'read-buildbot-config', 16:09:53 INFO - 'download-and-extract', 16:09:53 INFO - 'populate-webroot', 16:09:53 INFO - 'create-virtualenv', 16:09:53 INFO - 'install', 16:09:53 INFO - 'run-tests'), 16:09:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:53 INFO - 'download_minidump_stackwalk': True, 16:09:53 INFO - 'download_symbols': 'ondemand', 16:09:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:53 INFO - 'installer_path': 'installer.exe', 16:09:53 INFO - 'log_level': 'info', 16:09:53 INFO - 'log_name': 'talos', 16:09:53 INFO - 'log_to_console': True, 16:09:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:09:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:09:53 INFO - 'opt_config_files': (), 16:09:53 INFO - 'pip_index': False, 16:09:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:53 INFO - 'cmd': ('bash', 16:09:53 INFO - '-c', 16:09:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:53 INFO - 'enabled': True, 16:09:53 INFO - 'halt_on_failure': False, 16:09:53 INFO - 'name': 'check_screen_resolution'},), 16:09:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:53 INFO - 'cmd': ('bash', 16:09:53 INFO - '-c', 16:09:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:53 INFO - 'enabled': True, 16:09:53 INFO - 'halt_on_failure': False, 16:09:53 INFO - 'name': 'check_screen_resolution'},), 16:09:53 INFO - 'run_cmd_checks_enabled': True, 16:09:53 INFO - 'sps_profile': False, 16:09:53 INFO - 'sps_profile_interval': 0, 16:09:53 INFO - 'suite': 'dromaeojs-e10s', 16:09:53 INFO - 'system_bits': '32', 16:09:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:53 INFO - 'title': 't-yosemite-r7-0153', 16:09:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:53 INFO - 'use_talos_json': True, 16:09:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:53 INFO - 'work_dir': 'build'} 16:09:53 INFO - [mozharness: 2016-10-05 23:09:53.289278Z] Running clobber step. 16:09:53 INFO - Running pre-action listener: _resource_record_pre_action 16:09:53 INFO - Running main action method: clobber 16:09:53 INFO - rmtree: /builds/slave/test/build 16:09:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:55 INFO - Running post-action listener: _resource_record_post_action 16:09:55 INFO - [mozharness: 2016-10-05 23:09:55.520859Z] Finished clobber step (success) 16:09:55 INFO - [mozharness: 2016-10-05 23:09:55.520979Z] Running read-buildbot-config step. 16:09:55 INFO - Running pre-action listener: _resource_record_pre_action 16:09:55 INFO - Running main action method: read_buildbot_config 16:09:55 INFO - Using buildbot properties: 16:09:55 INFO - { 16:09:55 INFO - "project": "", 16:09:55 INFO - "product": "firefox", 16:09:55 INFO - "script_repo_revision": "production", 16:09:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:09:55 INFO - "repository": "", 16:09:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:09:55 INFO - "buildid": "20161005135000", 16:09:55 INFO - "pgo_build": "False", 16:09:55 INFO - "basedir": "/builds/slave/test", 16:09:55 INFO - "buildnumber": 133, 16:09:55 INFO - "slavename": "t-yosemite-r7-0153", 16:09:55 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:09:55 INFO - "platform": "yosemite_r7", 16:09:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:09:55 INFO - "branch": "mozilla-aurora", 16:09:55 INFO - "repo_path": "releases/mozilla-aurora", 16:09:55 INFO - "revision": "e666c7433e2fb5bd3f49a1e011170feca4571bd2", 16:09:55 INFO - "stage_platform": "macosx64", 16:09:55 INFO - "builduid": "82443e5d3c9e4715a1b12f9c78dcdadb", 16:09:55 INFO - "slavebuilddir": "test" 16:09:55 INFO - } 16:09:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:09:55 INFO - Running post-action listener: _resource_record_post_action 16:09:55 INFO - [mozharness: 2016-10-05 23:09:55.523988Z] Finished read-buildbot-config step (success) 16:09:55 INFO - [mozharness: 2016-10-05 23:09:55.524095Z] Running download-and-extract step. 16:09:55 INFO - Running pre-action listener: _resource_record_pre_action 16:09:55 INFO - Running main action method: download_and_extract 16:09:55 INFO - mkdir: /builds/slave/test/build/tests 16:09:55 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:09:55 INFO - trying https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:09:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/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:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/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:09:56 INFO - Downloaded 1199 bytes. 16:09:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:09:56 INFO - Using the following test package requirements: 16:09:56 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:09:56 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:09:56 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:09:56 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'jsshell-mac.zip'], 16:09:56 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:09:56 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:09:56 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:09:56 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:09:56 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:09:56 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:09:56 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:09:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:09:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:09:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:09:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:09:57 INFO - Expected file size: 16434067 16:10:04 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:10:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:10:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:10:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:10:04 INFO - Expected file size: 16434067 16:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:10:12 INFO - Expected file size: 14414059 16:10: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:10:12 INFO - trying https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:10:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/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:10:15 INFO - Downloaded 115329076 bytes. 16:10:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:10:15 INFO - mkdir: /builds/slave/test/properties 16:10:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:15 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:15 INFO - Contents: 16:10:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:10:16 INFO - Running post-action listener: _resource_record_post_action 16:10:16 INFO - Running post-action listener: set_extra_try_arguments 16:10:16 INFO - [mozharness: 2016-10-05 23:10:16.505259Z] Finished download-and-extract step (success) 16:10:16 INFO - [mozharness: 2016-10-05 23:10:16.505403Z] Running populate-webroot step. 16:10:16 INFO - Running pre-action listener: _resource_record_pre_action 16:10:16 INFO - Running main action method: populate_webroot 16:10:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:16 INFO - '--tppagecycles', 16:10:16 INFO - '7'], 16:10:16 INFO - 'tests': ['tsvgm']}}, 16:10:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['damp', 'tps']}, 16:10:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['damp', 'tps']}, 16:10:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['dromaeo_dom']}, 16:10:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['basic_compositor_video']}, 16:10:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:10:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tsvgx', 16:10:16 INFO - 'tsvgr_opacity', 16:10:16 INFO - 'tart', 16:10:16 INFO - 'tscrollx', 16:10:16 INFO - 'cart']}, 16:10:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:16 INFO - 'tsvgr_opacity', 16:10:16 INFO - 'tart', 16:10:16 INFO - 'tscrollx', 16:10:16 INFO - 'cart']}, 16:10:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tp5o']}, 16:10:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['tp5o']}, 16:10:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s', 16:10:16 INFO - '--xperf_path', 16:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:16 INFO - 'tests': ['tp5n']}, 16:10:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--xperf_path', 16:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:16 INFO - 'tests': ['tp5n']}}, 16:10:16 INFO - 'talos.zip': {'path': '', 16:10:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:16 INFO - Running post-action listener: _resource_record_post_action 16:10:16 INFO - [mozharness: 2016-10-05 23:10:16.523906Z] Finished populate-webroot step (success) 16:10:16 INFO - [mozharness: 2016-10-05 23:10:16.524038Z] Running create-virtualenv step. 16:10:16 INFO - Running pre-action listener: _resource_record_pre_action 16:10:16 INFO - Running main action method: create_virtualenv 16:10:16 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:16 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:10:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:16 INFO - Using real prefix '/tools/python27' 16:10:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:17 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:20 INFO - Installing pip.................done. 16:10:20 INFO - Return code: 0 16:10:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:20 INFO - 'HOME': '/Users/cltbld', 16:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:20 INFO - 'LOGNAME': 'cltbld', 16:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:20 INFO - 'MOZ_NO_REMOTE': '1', 16:10:20 INFO - 'NO_EM_RESTART': '1', 16:10:20 INFO - 'PAGER': '/bin/cat', 16:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:20 INFO - 'PWD': '/builds/slave/test', 16:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:20 INFO - 'SHELL': '/bin/bash', 16:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:20 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:20 INFO - 'USER': 'cltbld', 16:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:20 INFO - 'XPC_FLAGS': '0x0', 16:10:20 INFO - 'XPC_SERVICE_NAME': '0', 16:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:20 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:10:20 INFO - Cleaning up... 16:10:20 INFO - Return code: 0 16:10:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:20 INFO - 'HOME': '/Users/cltbld', 16:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:20 INFO - 'LOGNAME': 'cltbld', 16:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:20 INFO - 'MOZ_NO_REMOTE': '1', 16:10:20 INFO - 'NO_EM_RESTART': '1', 16:10:20 INFO - 'PAGER': '/bin/cat', 16:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:20 INFO - 'PWD': '/builds/slave/test', 16:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:20 INFO - 'SHELL': '/bin/bash', 16:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:20 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:20 INFO - 'USER': 'cltbld', 16:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:20 INFO - 'XPC_FLAGS': '0x0', 16:10:20 INFO - 'XPC_SERVICE_NAME': '0', 16:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:20 INFO - Downloading/unpacking psutil>=3.1.1 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:24 INFO - Installing collected packages: psutil 16:10:24 INFO - Running setup.py install for psutil 16:10:24 INFO - building 'psutil._psutil_osx' extension 16:10:24 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:10:25 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:10:25 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:10:25 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:10:25 INFO - building 'psutil._psutil_posix' extension 16:10:25 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:10:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:10:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:10:25 INFO - ^ 16:10:25 INFO - 1 warning generated. 16:10:25 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:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:25 INFO - Successfully installed psutil 16:10:25 INFO - Cleaning up... 16:10:25 INFO - Return code: 0 16:10:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10: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:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:25 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:25 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:10:25 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:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:25 INFO - 'HOME': '/Users/cltbld', 16:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:25 INFO - 'LOGNAME': 'cltbld', 16:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:25 INFO - 'MOZ_NO_REMOTE': '1', 16:10:25 INFO - 'NO_EM_RESTART': '1', 16:10:25 INFO - 'PAGER': '/bin/cat', 16:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:25 INFO - 'PWD': '/builds/slave/test', 16:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:25 INFO - 'SHELL': '/bin/bash', 16:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:25 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:25 INFO - 'USER': 'cltbld', 16:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:25 INFO - 'XPC_FLAGS': '0x0', 16:10:25 INFO - 'XPC_SERVICE_NAME': '0', 16:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:28 INFO - Installing collected packages: mozsystemmonitor 16:10:28 INFO - Running setup.py install for mozsystemmonitor 16:10:28 INFO - Successfully installed mozsystemmonitor 16:10:28 INFO - Cleaning up... 16:10:28 INFO - Return code: 0 16:10:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:28 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:10:28 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:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:28 INFO - 'HOME': '/Users/cltbld', 16:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:28 INFO - 'LOGNAME': 'cltbld', 16:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:28 INFO - 'MOZ_NO_REMOTE': '1', 16:10:28 INFO - 'NO_EM_RESTART': '1', 16:10:28 INFO - 'PAGER': '/bin/cat', 16:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:28 INFO - 'PWD': '/builds/slave/test', 16:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:28 INFO - 'SHELL': '/bin/bash', 16:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:28 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:28 INFO - 'USER': 'cltbld', 16:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:28 INFO - 'XPC_FLAGS': '0x0', 16:10:28 INFO - 'XPC_SERVICE_NAME': '0', 16:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:28 INFO - Downloading/unpacking jsonschema==2.5.1 16:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:10:31 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:10:31 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:10:31 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:10:31 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:10:31 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:10:31 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:10:31 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:31 INFO - warning: no files found matching '*.txt' 16:10:31 INFO - no previously-included directories found matching 'build' 16:10:31 INFO - no previously-included directories found matching 'dist' 16:10:31 INFO - no previously-included directories found matching '.git*' 16:10:31 INFO - Installing collected packages: jsonschema, functools32 16:10:31 INFO - Running setup.py install for functools32 16:10:32 INFO - warning: no files found matching '*.txt' 16:10:32 INFO - no previously-included directories found matching 'build' 16:10:32 INFO - no previously-included directories found matching 'dist' 16:10:32 INFO - no previously-included directories found matching '.git*' 16:10:32 INFO - Successfully installed jsonschema functools32 16:10:32 INFO - Cleaning up... 16:10:32 INFO - Return code: 0 16:10:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:32 INFO - 'HOME': '/Users/cltbld', 16:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:32 INFO - 'LOGNAME': 'cltbld', 16:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:32 INFO - 'MOZ_NO_REMOTE': '1', 16:10:32 INFO - 'NO_EM_RESTART': '1', 16:10:32 INFO - 'PAGER': '/bin/cat', 16:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:32 INFO - 'PWD': '/builds/slave/test', 16:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:32 INFO - 'SHELL': '/bin/bash', 16:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:32 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:32 INFO - 'USER': 'cltbld', 16:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:32 INFO - 'XPC_FLAGS': '0x0', 16:10:32 INFO - 'XPC_SERVICE_NAME': '0', 16:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:10:32 INFO - Cleaning up... 16:10:32 INFO - Return code: 0 16:10:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:32 INFO - 'HOME': '/Users/cltbld', 16:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:32 INFO - 'LOGNAME': 'cltbld', 16:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:32 INFO - 'MOZ_NO_REMOTE': '1', 16:10:32 INFO - 'NO_EM_RESTART': '1', 16:10:32 INFO - 'PAGER': '/bin/cat', 16:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:32 INFO - 'PWD': '/builds/slave/test', 16:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:32 INFO - 'SHELL': '/bin/bash', 16:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:32 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:32 INFO - 'USER': 'cltbld', 16:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:32 INFO - 'XPC_FLAGS': '0x0', 16:10:32 INFO - 'XPC_SERVICE_NAME': '0', 16:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:32 INFO - Downloading/unpacking blobuploader==1.2.4 16:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:36 INFO - Downloading docopt-0.6.1.tar.gz 16:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:36 INFO - Running setup.py install for blobuploader 16:10:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:36 INFO - Running setup.py install for requests 16:10:37 INFO - Running setup.py install for docopt 16:10:37 INFO - Successfully installed blobuploader requests docopt 16:10:37 INFO - Cleaning up... 16:10:37 INFO - Return code: 0 16:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10: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:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:37 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:10:37 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:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:37 INFO - 'HOME': '/Users/cltbld', 16:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PAGER': '/bin/cat', 16:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:37 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - 'XPC_FLAGS': '0x0', 16:10:37 INFO - 'XPC_SERVICE_NAME': '0', 16:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:37 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-hJlYEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:37 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5rz_so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:37 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-s7Fedf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:37 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-aP31W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:37 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-awUgJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ovoNYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-h2VHAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AnMDOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-SHoXZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-mqUbx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-W7_s18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-N1VYAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-gvsWkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:38 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_ZHyjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:39 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iXT8ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:39 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-q9V7Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:39 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-3pxs1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:39 INFO - Running setup.py install for manifestparser 16:10:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:39 INFO - Running setup.py install for mozcrash 16:10:39 INFO - Running setup.py install for mozdebug 16:10:39 INFO - Running setup.py install for mozdevice 16:10:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:39 INFO - Running setup.py install for mozfile 16:10:40 INFO - Running setup.py install for mozhttpd 16:10:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Running setup.py install for mozinfo 16:10:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Running setup.py install for mozInstall 16:10:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Running setup.py install for mozleak 16:10:40 INFO - Running setup.py install for mozlog 16:10:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Running setup.py install for moznetwork 16:10:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Running setup.py install for mozprocess 16:10:41 INFO - Running setup.py install for mozprofile 16:10:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:41 INFO - Running setup.py install for mozrunner 16:10:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:41 INFO - Running setup.py install for mozscreenshot 16:10:41 INFO - Running setup.py install for moztest 16:10:41 INFO - Running setup.py install for mozversion 16:10:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:41 INFO - Cleaning up... 16:10:41 INFO - Return code: 0 16:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:41 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:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:41 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:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:41 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:41 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:10:41 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:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:41 INFO - 'HOME': '/Users/cltbld', 16:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:41 INFO - 'LOGNAME': 'cltbld', 16:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:41 INFO - 'MOZ_NO_REMOTE': '1', 16:10:41 INFO - 'NO_EM_RESTART': '1', 16:10:41 INFO - 'PAGER': '/bin/cat', 16:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:41 INFO - 'PWD': '/builds/slave/test', 16:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:41 INFO - 'SHELL': '/bin/bash', 16:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:41 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:41 INFO - 'USER': 'cltbld', 16:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:41 INFO - 'XPC_FLAGS': '0x0', 16:10:41 INFO - 'XPC_SERVICE_NAME': '0', 16:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0PafM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-IZpHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4jsrQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-jKqvC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-R0CmSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-eH7uFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-JydoDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:42 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:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-hp13gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-MPUoLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QGlXVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-L1bezt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VIUfcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5axnBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-JNjgSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-KIEgq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-dQ2Omb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EZdW60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:44 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:10:44 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:10:44 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:10:44 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:10:44 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:10:44 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:10:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:44 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:10:44 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:10:44 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:10:44 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:10:44 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:10:44 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:10:46 INFO - Downloading blessings-1.6.tar.gz 16:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:46 INFO - Installing collected packages: blessings 16:10:46 INFO - Running setup.py install for blessings 16:10:46 INFO - Successfully installed blessings 16:10:46 INFO - Cleaning up... 16:10:46 INFO - Return code: 0 16:10:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:47 INFO - Reading from file tmpfile_stdout 16:10:47 INFO - Current package versions: 16:10:47 INFO - blessings == 1.6 16:10:47 INFO - blobuploader == 1.2.4 16:10:47 INFO - docopt == 0.6.1 16:10:47 INFO - functools32 == 3.2.3-2 16:10:47 INFO - jsonschema == 2.5.1 16:10:47 INFO - manifestparser == 1.1 16:10:47 INFO - mozInstall == 1.12 16:10:47 INFO - mozcrash == 0.17 16:10:47 INFO - mozdebug == 0.1 16:10:47 INFO - mozdevice == 0.48 16:10:47 INFO - mozfile == 1.2 16:10:47 INFO - mozhttpd == 0.7 16:10:47 INFO - mozinfo == 0.9 16:10:47 INFO - mozleak == 0.1 16:10:47 INFO - mozlog == 3.4 16:10:47 INFO - moznetwork == 0.27 16:10:47 INFO - mozprocess == 0.23 16:10:47 INFO - mozprofile == 0.28 16:10:47 INFO - mozrunner == 6.12 16:10:47 INFO - mozscreenshot == 0.1 16:10:47 INFO - mozsystemmonitor == 0.3 16:10:47 INFO - moztest == 0.7 16:10:47 INFO - mozversion == 1.4 16:10:47 INFO - psutil == 3.1.1 16:10:47 INFO - requests == 1.2.3 16:10:47 INFO - wsgiref == 0.1.2 16:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:47 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:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:47 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:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:47 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:47 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:10:47 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:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:47 INFO - 'HOME': '/Users/cltbld', 16:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:47 INFO - 'LOGNAME': 'cltbld', 16:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:47 INFO - 'MOZ_NO_REMOTE': '1', 16:10:47 INFO - 'NO_EM_RESTART': '1', 16:10:47 INFO - 'PAGER': '/bin/cat', 16:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:47 INFO - 'PWD': '/builds/slave/test', 16:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:47 INFO - 'SHELL': '/bin/bash', 16:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:47 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:47 INFO - 'USER': 'cltbld', 16:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:47 INFO - 'XPC_FLAGS': '0x0', 16:10:47 INFO - 'XPC_SERVICE_NAME': '0', 16:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 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:10:47 INFO - Cleaning up... 16:10:47 INFO - Return code: 0 16:10:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:47 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:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:47 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:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:47 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 0x10f4cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f441570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe22158e1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, '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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:10:47 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:10:47 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:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:47 INFO - 'HOME': '/Users/cltbld', 16:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:47 INFO - 'LOGNAME': 'cltbld', 16:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:47 INFO - 'MOZ_NO_REMOTE': '1', 16:10:47 INFO - 'NO_EM_RESTART': '1', 16:10:47 INFO - 'PAGER': '/bin/cat', 16:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:47 INFO - 'PWD': '/builds/slave/test', 16:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:47 INFO - 'SHELL': '/bin/bash', 16:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:10:47 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:47 INFO - 'USER': 'cltbld', 16:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:47 INFO - 'XPC_FLAGS': '0x0', 16:10:47 INFO - 'XPC_SERVICE_NAME': '0', 16:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:10:47 INFO - Cleaning up... 16:10:47 INFO - Return code: 0 16:10:47 INFO - Running post-action listener: _resource_record_post_action 16:10:47 INFO - Running post-action listener: _start_resource_monitoring 16:10:47 INFO - Starting resource monitoring. 16:10:47 INFO - [mozharness: 2016-10-05 23:10:47.731892Z] Finished create-virtualenv step (success) 16:10:47 INFO - [mozharness: 2016-10-05 23:10:47.732926Z] Running install step. 16:10:47 INFO - Running pre-action listener: _resource_record_pre_action 16:10:47 INFO - Running main action method: install 16:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:47 INFO - Reading from file tmpfile_stdout 16:10:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:48 INFO - Reading from file tmpfile_stdout 16:10:48 INFO - Output received: 16:10:48 INFO - Usage: mozinstall [options] installer 16:10:48 INFO - Options: 16:10:48 INFO - -h, --help show this help message and exit 16:10:48 INFO - -d DEST, --destination=DEST 16:10:48 INFO - Directory to install application into. [default: 16:10:48 INFO - "/builds/slave/test"] 16:10:48 INFO - --app=APP Application being installed. [default: firefox] 16:10:48 INFO - mkdir: /builds/slave/test/build/application 16:10:48 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:10:48 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:11:19 INFO - Reading from file tmpfile_stdout 16:11:19 INFO - Output received: 16:11:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:11:19 INFO - Running post-action listener: _resource_record_post_action 16:11:19 INFO - [mozharness: 2016-10-05 23:11:19.930107Z] Finished install step (success) 16:11:19 INFO - [mozharness: 2016-10-05 23:11:19.930270Z] Running run-tests step. 16:11:19 INFO - Running pre-action listener: _resource_record_pre_action 16:11:19 INFO - Running main action method: run_tests 16:11:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:11:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:11:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:11:19 INFO - 2016-10-05 16:11:19.944 screenresolution[1651:8470] starting screenresolution argv=screenresolution get 16:11:19 INFO - 2016-10-05 16:11:19.947 screenresolution[1651:8470] Display 0: 1600x1200x32@60 16:11:19 INFO - 2016-10-05 16:11:19.952 screenresolution[1652:8473] starting screenresolution argv=screenresolution list 16:11:19 INFO - Available Modes on Display 0 16:11:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:11:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:11:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:11:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:11:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:11:20 INFO - Intel Iris: 16:11:20 INFO - Chipset Model: Intel Iris 16:11:20 INFO - Type: GPU 16:11:20 INFO - Bus: Built-In 16:11:20 INFO - VRAM (Dynamic, Max): 1536 MB 16:11:20 INFO - Vendor: Intel (0x8086) 16:11:20 INFO - Device ID: 0x0a2e 16:11:20 INFO - Revision ID: 0x0009 16:11:20 INFO - Displays: 16:11:20 INFO - Display: 16:11:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:11:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:11:20 INFO - Display Serial Number: 1600x1200 60 16:11:20 INFO - Main Display: Yes 16:11:20 INFO - Mirror: Off 16:11:20 INFO - Online: Yes 16:11:20 INFO - Rotation: Supported 16:11:20 INFO - Return code: 0 16:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:20 INFO - Python 2.7.3 16:11:20 INFO - Return code: 0 16:11:20 INFO - grabbing minidump binary from tooltool 16:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:20 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 0x10f2dfd30>, '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 0x10f145db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:20 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:11:20 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:11:20 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:11:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:20 INFO - Return code: 0 16:11:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vbqse4Kurk/Render', 16:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:20 INFO - 'HOME': '/Users/cltbld', 16:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:20 INFO - 'LOGNAME': 'cltbld', 16:11:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:20 INFO - 'MOZ_NO_REMOTE': '1', 16:11:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:20 INFO - 'NO_EM_RESTART': '1', 16:11:20 INFO - 'PAGER': '/bin/cat', 16:11:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:20 INFO - 'PWD': '/builds/slave/test', 16:11:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:20 INFO - 'SHELL': '/bin/bash', 16:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JD2CgSWhLK/Listeners', 16:11:20 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 16:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:20 INFO - 'USER': 'cltbld', 16:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:20 INFO - 'XPC_FLAGS': '0x0', 16:11:20 INFO - 'XPC_SERVICE_NAME': '0', 16:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:11:20 INFO - mozversion application_buildid: 20161005135000 16:11:20 INFO - mozversion application_changeset: e666c7433e2fb5bd3f49a1e011170feca4571bd2 16:11:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:11:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:20 INFO - mozversion application_name: Firefox 16:11:20 INFO - mozversion application_remotingname: firefox-dev 16:11:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:11:20 INFO - mozversion application_vendor: Mozilla 16:11:20 INFO - mozversion application_version: 51.0a2 16:11:20 INFO - mozversion platform_buildid: 20161005135000 16:11:20 INFO - mozversion platform_changeset: e666c7433e2fb5bd3f49a1e011170feca4571bd2 16:11:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:11:20 INFO - mozversion platform_version: 51.0a2 16:11:20 INFO - using testdate: 1475709080 16:11:20 INFO - actual date: 1475709080 16:11:20 INFO - starting webserver on 'localhost:49277' 16:11:20 INFO - SUITE-START | Running 2 tests 16:11:20 INFO - TEST-START | dromaeo_css 16:11:20 INFO - operating with platform_type : mac_ 16:11:20 INFO - Initialising browser for dromaeo_css test... 16:11:20 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpYPxs8I/profile http://localhost:49277/getInfo.html) 16:11:23 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 16:11:23 INFO - PROCESS | 1662 | colorDepth:24 16:11:23 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 16:11:23 INFO - PROCESS | 1662 | __metrics 16:11:23 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:11:24 INFO - TEST-INFO | 1662: exit 0 16:11:24 INFO - Browser initialized. 16:11:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:24 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpYPxs8I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:36 INFO - PROCESS | 1666 | RSS: Main: 224747520 16:11:36 INFO - PROCESS | 1666 | 16:12:25 INFO - PROCESS | 1666 | 1475709145770 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:14:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 16:14:38 INFO - PROCESS | 1666 | RSS: Main: 237907968 16:14:38 INFO - PROCESS | 1666 | 16:17:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 16:17:41 INFO - PROCESS | 1666 | RSS: Main: 248778752 16:17:41 INFO - PROCESS | 1666 | 16:20:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 16:20:44 INFO - PROCESS | 1666 | RSS: Main: 251269120 16:20:44 INFO - PROCESS | 1666 | 16:23:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 16:23:46 INFO - PROCESS | 1666 | RSS: Main: 251486208 16:23:46 INFO - PROCESS | 1666 | 16:26:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 16:26:50 INFO - PROCESS | 1666 | RSS: Main: 255758336 16:26:50 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 16:29:52 INFO - PROCESS | 1666 | RSS: Main: 257691648 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | __start_tp_report 16:29:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 16:29:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 16:29:52 INFO - PROCESS | 1666 | |i|pagename|runs| 16:29:52 INFO - PROCESS | 1666 | |0;dojo.html;2946.9263268418285;3455.9827200863992;3459.2389674271667;3477.843497042633;3501.9649803501975;4577.542245775429;5876.382979787119;5948.7620495180145;5961.433663801938;5962.552808539355;5895.292564892208;5983.700814959257;6005.789797357093;6006.219191505098;6020.698965051752;5286.894262114765;5401.4868587484325;5414.648047876875;5432.049391356497;5459.945400545984;4455.598996090367;5416.322959630046;5418.133098704208;5454.972725136368;5484.588655850807;5316.415194328621;5325.094733895227;5415.729213539327;5417.133258678612;5436.21174929637;5339.199120131972;5342.679439233659;5391.16436952273;5453.972730136324;5483.8080667176855;5257.211418287249;5374.4894235048;5378.865528361822;5399.811006614749;5479.397266300703;4214.810333534998;5819.854503637401;6029.487493563052;6082.908756368658;6087.726052327655;4839.879003024917;6051.636901785907;6097.359777223416;6203;6372.968135159341;5862.601770963318;6089.451949324538;6351.87296254077;6391.328910464381;6411.134496842913;6115.510759139258;6131.50947924165;6134.69326533676;6142.477889379453;6144.2319710036245;6276.278228003746;6351.460125889259;6365.172527571386;6392.616443013434;6438.6136831790245;6216.875662486725;6257.155284036597;6267.435930766253;6271.059341098871;6274.435300822948;6395;6396.328385519547;6396.5202609804455;6403.839904002437;6427.132337134427;6186.845328866724;6203.689815509207;6206.348333424925;6236.594621349598;6237.688115594202;6259.71831267594;6280.466160376328;6309.873802523924;6337.017762246859;6349.365063493706;5078.873028174326;5085.1355269604255;5095.210242412432;5097.898042039138;5119.360079990001;4411.22803509391;4470.798814053375;4500.009997800478;4547.13309047359;4595.862124136282;6112.358202388774;6115.755369785248;6134;6152.316563929193;6171.228596425447;6391.872162556723;6410;6423.903641445382;6425.935740642627;6498.480121590356;5998.970005150034;6069.302030266487;6069.393060693984;6115.51416190291;6172.4136207060255;4779.641526885497;5622.184783206412;5631.958087753778;5651;5671.234383358276;6251.906221406683;6592.077109204811;6616.437602803816;6651.368120028589;6662.233843108104;6189.1025801257665;6249.843753906189;6273.027680709497;6401.64790936503;6489.448396886129;6502.4472919800455;6618.371254730793;6621.668916554249;6649.168853893263;6651.50113741481;6311.526635502448;6311.652859092794;6318.6840657965995;6318.894193516025;6348.650824204528;6063.575549711478;6242.406971337716;6326.272478664829;6354.4598709108395;6367.42693157618;5131.281620573197;6145.217886812953;6155.076738489262;6202.5658203925295;6251.499880009679;6221.657808820558;6232.937670623236;6236.937630623635;6239.563230573816;6332.905006425;5537.947128278309;6028.788992385245;6057.697115144313;6109.205803245727;6147.231596050494;6132.998044146438;6165.537584681257;6173.259208894781;6220.968895155676;6253.499720022296;6092.329843717276;6128.019516877278;6142.109394137736;6167.167432396569;6238.189035425366 16:29:52 INFO - PROCESS | 1666 | |1;ext.html;463.35824882537685;488.2968525323534;498.4865588443902;529.6133822309716;543.0496630895932;41930.742077737676;42616.9345766356;42633.78683106584;44584.55415445845;44595.77702111493;40711;44282.55717442824;44732.77633611827;44744.552554474445;44850.551494485044;7812.101608315045;8189.672413103469;9925.205983521337;9926.45404502752;9934.304598678096;9696.660616878411;9781.168600668952;9826.606935722562;9829.164521015686;9842.557084931195;8386.496810191407;9800.117989380955;9841.655542056029;9845.803083938317;9860.556274967608;9761.219102471785;9800.068993445611;9816.803663926752;9820.754481137958;9838.557264923023;8228.711995080203;8394.748157555283;9751.219902407862;9799.461029643368;9812.607495700164;41815.372769408175;41983.37024944598;42078.57921420777;42209.57790422118;42241.788791056155;3332.8333583320737;3360;3469.8612055517747;3549.964500354989;3565.983694647013;31495.685043149504;31679.366412671618;31775.841120794248;31784.523232151536;32134.196645083826;3195.568598239231;3243;3284.014795561322;3295.3244584860045;3394.01573543672;536888;541023;542123;547404;548071.999999996;53404.465955340725;63411.04883426752;63609.68195158995;63686.36313636897;63771.36228637654;34778.82610586981;35243.64756352455;35703.28593428117;36480.817595912384;36675.449868252;17268.827311726724;17405.042722650123;17412.47762567125;17521.7371739424;17532.298708051534;11123.833142502868;13141.868581314257;13309.40107695156;13316.533921312708;13323.533676321282;19543;19567;19855.30506432297;19876.006199689957;19895.502612434517;7649.464537482323;7807.69998005182;7829.256220659028;7850.56821874791;7911.208879112158;857.1728282207699;914.2320450821342;953.3612479638658;959.6353385713384;1063.505469956474;25039.499210015696;29813.403731925675;30544.08367748971;30845.69154308473;31146.844265778527;913.2967614936462;1055.630529314749;1071.614218881202;1096.857408536901;1125.8254970479588;15681.137537435323;15863.365465381255;15977.360905563879;16027.278772455034;16270.83729162717;707795;717045;718956;721349;721543;59295;59533;59745.80508389808;59845.40154598485;59877.700611496664;1344.2942455210896;1346.7912473566612;1374.4364810427676;1377.6142680049602;1382.3710211853381;24474;29224.561631575118;29755.851220743756;30032.549511756904;31072.689273107884;54510.727446362514;57686.84626307366;58353.4164658348;58384.70807645935;58508;647712;650739;650818;656598;657838;43887;44529.88675283144;44540;44725.55274447214;44955.32567011432;48807;49196.50803491919;49202.753986229836;49918.75040624774;50465.49534504608;39373.62192323255;39774.204515910096;40246.79876600598;40868.79565602153;41602;32477.51283730793;37827.432588510645;39643.405348919216;39883;41185;33538.993830185136;33545;37178.8141059293;39144.608553915234;39515.40726889041;29103.417931640826;33454.49818252777;35838.283234335686;35905.64094359023;36037.81981090078;26225.73774262233;26247.950081996507;26493.735062649128;26675.06637267686;27145.59281610738 16:29:52 INFO - PROCESS | 1666 | |2;jquery.html;326.9542264083028;329.2328873724221;387.38405934564037;388.97471664341833;405.4546634776225;19293.903530482363;19585.902070489647;20334.389968300973;20893.686594701092;21128.788712112873;19627.411177664657;19895.502612434695;19930.302439414587;20100.296489622866;20333.796662033375;5175.275461435402;5738.454846789548;5883.970580147104;6130.877382452349;6147.631142131464;5912.408759124075;6069.817905462821;6069.817905462844;6070.878582428349;6079.817605471821;5938.673372964486;6032.849178770522;6034.577579569432;6634.402903738663;6704.865902681943;5624.803131890364;5640.266765320503;6677.699503522304;6688.565243259197;6721.193456785192;5583.218349431083;5776.566757493205;5825.097109947922;5831.912521312183;5846.239988801429;12502.187357821804;12878.162919410208;12922.966162707055;18341.7248741269;24711.62932556013;2084.530980529384;2141.957160856774;2145.5065334972887;2262.7058482397347;2420.9394765130837;9923.851142232872;9993.150582200522;10091.79816403675;10179.338343007756;13728.93135534316;1866.3747644539096;1885.764279465067;1912.3211260002777;1949.83426408754;1953.5018570264633;128987;130349;130900.34549827286;133226;133687.33156334254;9065.320100992452;11432.942835285936;11547.538098475967;11619.419029048513;11805.763884722257;14396.064255823338;14427.567172984827;14441.277936103153;14456.27718614065;14464.27678616086;8538.146185381536;8576.742697719079;8606.483610983236;8646;8721.17148870869;8537.402381833337;8564.700235491728;8614.698485552975;8624.706294055817;8743.300535957109;4465.4864690561;4483.865484035484;4493.528179541101;4498.280275155959;4551.817927282872;1906.428071578521;1914.5596512802133;1933.6712758831034;1937.5156210947264;1977.5550501137416;820.306840719591;943.8159558885951;977.2231076294363;1016.466355163545;1027.8715160604925;20183.39449816508;20410.69383959242;20486.38540843777;20684.379468615967;20749.1700331985;922.7761095759188;935.4995077633433;947.8862536495527;966.3766870368573;1004.8191325561469;10639.148868090535;10801.73374613003;10847.288676236076;10863.52226053894;10960.232783705063;620013;623316;634462;635314;643572;102378;106185.46907265414;122952.38523807324;146162;146282;873.6418068591973;885.8051228729669;971.3443425687633;994;1023.5803320638652;15151.772723408938;18530.81469185291;18934.43196704101;18946.715799262747;18956.620867582846;47903.84432700607;54152.45847541474;58293;58651.4134858663;59392.81214375602;77473.22526774886;83683.5815820917;84192.57903710687;85276.4417067489;85434;6895.862182739792;7994.84010319802;8009.679612815422;8058.597070146352;8093.878591821245;10362.844557331797;11227;12551.623451296477;12736.6815829605;12922.353882306035;10336.948315258676;10821.242513024014;10854.945725271638;10908.836367454336;11213.943930280297;10611.469426528489;10811.24321297533;10853.131749460183;10991.120710342993;11063.889361106287;10772.407517586607;11022.173336999596;11191.66425007251;11528.365939873387;11581.478833452684;7418.221086786026;7574.3183113520045;7719.189485103983;7901.9032723893915;7919.16848730898;9737.269704772028;10532.89467105319;10581.576736930436;10865.456727163451;11033.227674062739 16:29:52 INFO - PROCESS | 1666 | |3;mootools.html;1489.6424858034072;1493.0593725952651;1730.420309196419;1848.6857234270174;1889.5559543507272;8164.7550573482895;8447.408681392306;8674.653013879446;9269.629214831399;9285;8752.737417877457;9064.27485801136;9078.954605226965;9153.359264851462;9162.86255706165;1939.6411663842234;2403.8076953843693;2413.987930060356;2452.8405653632544;2454.410941374066;2346.9413264668433;2416.347586151738;2418.9758102419014;2423.3941514621347;2433.3429973907037;2422.648715936197;2425.139075628153;2425.963610545843;2432.586460301753;2440.0727723465147;2406.819488538367;2407.434252950555;2419.6491508731224;2422.406510404962;2431.197704757426;2350.059976009593;2383.690120284352;2384.8807559622123;2391.1391898916377;2395.9035843636816;8989.190972812477;9046.81906361869;9078.818423631556;9114.088591140899;9119.49842758648;5381.650192737459;5526.640768350045;5563.749631266603;5566.081596536566;5586.162075688639;3610.332088563598;3660.981695091534;3668.394714872043;3675.72432067596;3720.2373513429684;1047.8899715529913;1068.4871261794383;1068.7541865370931;1080.4867687848289;1089.319175515303;12001.159918805688;12001.759964800742;12147.392630368446;12222.816657750142;12224.02207823381;4860.1737704590305;4873.756312184377;4903.730294833747;5001.399832020181;5003.924941125886;10342;10446.320989135835;10455.059044686015;10460.947695261475;10488.580456781796;5545.916811247835;5562.721863906789;5568.220449137124;5568.387477377485;5598.272224610774;4521.88695282614;4646.094011667692;4900.803967841318;5035.874103147451;5082.059818933509;4068.959310406917;4069.8575549856205;4160.043190066242;4203.243416185055;4269.167512335065;1111.4609414433994;1119.7480566872389;1312.3700623700677;1320.306838909561;1328.435414948643;670.6646676661669;843.3379796859435;901.6348378906554;912.4251721415466;923.0907556057278;4897.461279259279;5569.860753481114;5692.2330000892325;5947.762089516457;6202.875942481125;428.32752578451533;432.4486279993034;448.4013841521605;455.535353938987;462.9328747331618;3431.742619303562;4035.092104276573;4037.7981100944835;4075.91848163041;4083.060895993938;9844.9015509844;10741.892581074246;10780.245382823126;10995.9004099591;11076.667699969013;10839.783204335869;11011.504482298316;11129.833052504218;11144.387058711687;11156.219064665396;8381.455205411628;8505.064442911274;8516.787080322918;8529.061803201643;8547.316214702809;5824.417558244311;5916.585838991229;6066.302375226729;6067.393260673897;6126.356732543019;9514.429134251966;10289.228307876789;10343.224258180517;10392.948035260079;10410.895891040993;8337.83324333522;9948.154406875206;10417.322874013165;10588.629397971343;10596.47017649099;5984.461398474158;7353.411727061715;7597.582132982739;7726.304632583095;8181.67273309061;8519.403641745019;8623.913760862311;8686.956565217133;8764.035956044958;8791.824163516821;6533.542652014504;7560.357369623423;7670.501417407851;7685.923140768745;7724.613769311624;7431.442641801778;7460.626968651654;7543.245675432632;7631.69473221065;7695.923040769745;6858.41703455192;7185.389241914496;7277.126744790659;7297.671604777904;7311.8903216450735;5015.996800639814;5043.218301163325;5145.677630790155;5253.842384728464;5288.524032837063;5012.573931215888;5048.570871475818;5123.538881500683;5131.563817075441;5173.922391164211 16:29:52 INFO - PROCESS | 1666 | |4;prototype.html;312.25682874758076;314.99999999999983;318.905922752788;324.1361770880603;325.1967639929375;5141.305923700304;5496.395396506381;5649.039663257246;5652.745626446809;5704.429557044294;4740.4548476925165;5400.216968539569;5617.550595952324;5651.9152212716845;5689.301953730078;3998.280309544281;4257.6806739494505;4273.807678654468;4313.870583882489;4324.351347297915;3796.9937966438915;4082.2243773682903;4224.281872081738;4230.4500414946015;4362.934555981663;3924.038610540422;4275.850345237917;4287.1854347674;4292.699511034229;4295.165190973958;3902.5170435234713;3905.511811023622;4167.395727619493;4214.714512073816;4336.371226172203;3291.670832916713;3327.900162995114;3449.844756985942;3499.6850283474355;3560.946585801215;5045.798168073273;5107.61692873036;5116.002379535992;5425.321834770653;5523.28197334344;4613.792379342937;4757.9286310705365;5013.615809328725;5037.028153389481;5062.594992400599;4845.903081938377;5363;5645.834061833418;5972.343042265347;6027.47392775227;3312.3706495765728;3679.8344074516713;4097.774622395767;4107.630313271819;4125.792700905032;6203.7828675996125;6316.30520642729;6335.619862808247;6385.541566496886;6395.16862807832;4043.939340909889;4187.597154953125;4225.176090662291;4230.323148296319;4250.787460626956;3923.8614954849677;4257.318828987409;4259.467566554181;4259.893502662396;4322.891927701832;4369.919206959086;4463.888402789891;4522.389477420506;5006.974965125151;5032;4915.705057696549;5017.799288028511;5732.398098199712;6060.969695151496;6110.816675499742;1258.924464532131;1345.7039451320693;1401.4254155796075;1435.4473527691705;1470.0885451020436;825.6779855856221;839.9668407858246;884.7478468636408;906.2840356118725;908.8364094462928;4324.913501729948;4337.72965846498;4407.867763967086;4500.4149460569915;4710.528947105262;4513.751743654065;4530.886727831765;4694.976525117421;4988.503448965296;5263.131593281671;4060.2894493463527;4356.564343565618;4511.954880451219;4655.976720116378;4860.586850117709;2486.813488988333;2636.7890568754456;2727.986360068187;2924.692907244751;3227.708916433445;6466.870662586722;6502.382273684087;6520.836979075466;6528.673566321665;6531.575447595891;5463.879904619623;5694;5973.802791571361;6404.647744374011;6445.41991220783;5860.454425072855;6002.219711437485;6539.444147247537;6546.919758239837;6554.721829243252;5861.648301101947;6021.952536137735;6135.294441139147;6288.434040936338;6301.338359472373;5051.87370315745;5113.565346945551;5773.422657734193;5963.4334738199805;6179.0145356244075;6508.60948343082;6559.573627714183;6561.392458847613;6563.195121341479;6570.967145164243;3957.584453632327;4065;4075.573549257736;4086.897827554335;4112.773797441169;5470.370907345547;5817.738201781015;5823.194809609035;6184.5980011299125;6229.314775374796;5123.001014802227;5517.282753242213;5563.666180029211;5724.255846739898;6055.819115272656;5216.791328346823;5244.737763111752;5957.344692083954;5995.591036106599;6003.369646187088;5687.402822703722;5952.5237980960555;5962.940370596412;5978.312494063064;5979.850503737442;5105.846824595268;5804.332501762183;5940;5952.0797050753645;6033.969830150997;4916.778744956414;5858.765649374148;5898.94101058984;5911.788083442798;5930.970345148246 16:29:52 INFO - PROCESS | 1666 | |5;yui.html;702.7856503766352;706.6678661029317;777.1684297801352;791.4459878085335;808.9959550202248;15394.307256173472;15524.456644017462;15701.764473532907;15801.446949356761;15834;14262.643433914158;14274.4290228391;14287.071340362869;14296;14388.640283992905;674.6930146783226;696.923338432772;835.5446281776447;835.6239692138547;852.4544291653347;852.40757673417;856.9228769410752;857.5540718826206;857.9356548258875;859.9871001934976;860.5826174305457;909.3634455880876;917.8026724254285;920.8756817829608;923.0584803500426;917.8118485710413;919.4758987377197;920.3051695969567;923.3213588012806;930.9906900930972;676.0298970976664;682.4915437998723;684.4148253243504;684.8287928017995;685.7634116229892;14704.264786760727;14942.551723448314;14990.175540345277;15025.248737563079;15030.849691503163;14691.706165876623;14700.852991470056;14724.263786810616;14771.556853294418;14866.256687165707;11298.209125361229;11535.423228838608;11588.072954163647;11646.359450230233;12058.095642826824;3705.8517659293866;3797.1836055247977;3831.9042023949346;3846.7307288489815;3857.0164608025057;101297.97404051878;108587.45706271497;112739.43630281878;113311;125149;11259.887401125883;11318.94340528292;11413.942930285462;11417.429128543707;11694.532218711327;17857;22147.778522214572;23760.7623923762;23773.167939122046;23781.881090594783;7153.570785752768;8173.18268173178;8206.794830129174;8272.503649781032;8416.074231834493;3674.4855720199193;4408.162449134654;4429.911401771947;4563.863084107482;4578.381918440968;3647.6170002149925;3778.6032466590614;3779.244151169777;3780.981095094507;3792.355299599075;619.454879705856;619.9411055949768;627.3726273726273;631.962082275065;654.4927681047132;648.9578177418452;653.3335997282745;675.9459243260527;683.8427161752825;697.6197972105215;9014.18872301483;9593.904060959301;9621.9037809621;9641.903580964241;9761.267904907161;626.9216347956506;637.2639601260552;640.6892657061321;664.9135612370361;673.8147009572309;4738.64460165489;4749.572538471554;4751.477337492873;4752.904941901143;4753.976230118897;103994;104107;104972.2385005802;163237.18381408017;174506;143257;143586;143917;145960;147913;78897.60551197322;81735;89613;124452.42154416796;128127.35936320445;8935.329850261127;9066.274698024274;9103.226225770619;9131.908680913106;9347.859782103138;68377.31622683909;68419.65790171018;69526.5665701698;70034.29965700278;70624.64687676734;87552.1244787544;101628;105800;108026.4598677033;108747;9748.463834489172;11804.822927656263;11964.401779911144;11998.940005299917;12361.258324500559;12147;12316.938415307866;12385.19496232742;12542.24746515212;12568.371581421075;11845.940770296093;11932.22440541362;12231.327276999851;12420.813687794871;12747.681307967376;12077.076754527166;12211.938940305241;12304.938475307566;12347.506099755909;12625.87374126247;11770.411479425824;11788.4695188715;12171.878281217074;12217.755644887231;12593.055520835791;10358.896411036094;10384.740381490523;10437.68686939393;10685.732856678645;10823.350598964087;10362.222833287382;10518.421486818299;10550.947245263724;10554.947225263824;10563.63027294041 16:29:52 INFO - PROCESS | 1666 | __end_tp_report 16:29:52 INFO - PROCESS | 1666 | __start_cc_report 16:29:52 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,365 16:29:52 INFO - PROCESS | 1666 | __end_cc_report 16:29:52 INFO - PROCESS | 1666 | __startTimestamp1475710192925__endTimestamp 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | ------- Summary: start ------- 16:29:52 INFO - PROCESS | 1666 | Number of tests: 6 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5867.73 Median:6134.00 stddev:690.72 (11.3%) stddev-sans-first:653.73 16:29:52 INFO - PROCESS | 1666 | Values: 2946.9 3456.0 3459.2 3477.8 3502.0 4577.5 5876.4 5948.8 5961.4 5962.6 5895.3 5983.7 6005.8 6006.2 6020.7 5286.9 5401.5 5414.6 5432.0 5459.9 4455.6 5416.3 5418.1 5455.0 5484.6 5316.4 5325.1 5415.7 5417.1 5436.2 5339.2 5342.7 5391.2 5454.0 5483.8 5257.2 5374.5 5378.9 5399.8 5479.4 4214.8 5819.9 6029.5 6082.9 6087.7 4839.9 6051.6 6097.4 6203.0 6373.0 5862.6 6089.5 6351.9 6391.3 6411.1 6115.5 6131.5 6134.7 6142.5 6144.2 6276.3 6351.5 6365.2 6392.6 6438.6 6216.9 6257.2 6267.4 6271.1 6274.4 6395.0 6396.3 6396.5 6403.8 6427.1 6186.8 6203.7 6206.3 6236.6 6237.7 6259.7 6280.5 6309.9 6337.0 6349.4 5078.9 5085.1 5095.2 5097.9 5119.4 4411.2 4470.8 4500.0 4547.1 4595.9 6112.4 6115.8 6134.0 6152.3 6171.2 6391.9 6410.0 6423.9 6425.9 6498.5 5999.0 6069.3 6069.4 6115.5 6172.4 4779.6 5622.2 5632.0 5651.0 5671.2 6251.9 6592.1 6616.4 6651.4 6662.2 6189.1 6249.8 6273.0 6401.6 6489.4 6502.4 6618.4 6621.7 6649.2 6651.5 6311.5 6311.7 6318.7 6318.9 6348.7 6063.6 6242.4 6326.3 6354.5 6367.4 5131.3 6145.2 6155.1 6202.6 6251.5 6221.7 6232.9 6236.9 6239.6 6332.9 5537.9 6028.8 6057.7 6109.2 6147.2 6133.0 6165.5 6173.3 6221.0 6253.5 6092.3 6128.0 6142.1 6167.2 6238.2 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:76355.18 Median:42225.68 stddev:171945.51 (407.2%) stddev-sans-first:172333.45 16:29:52 INFO - PROCESS | 1666 | Values: 463.4 488.3 498.5 529.6 543.0 41930.7 42616.9 42633.8 44584.6 44595.8 40711.0 44282.6 44732.8 44744.6 44850.6 7812.1 8189.7 9925.2 9926.5 9934.3 9696.7 9781.2 9826.6 9829.2 9842.6 8386.5 9800.1 9841.7 9845.8 9860.6 9761.2 9800.1 9816.8 9820.8 9838.6 8228.7 8394.7 9751.2 9799.5 9812.6 41815.4 41983.4 42078.6 42209.6 42241.8 3332.8 3360.0 3469.9 3550.0 3566.0 31495.7 31679.4 31775.8 31784.5 32134.2 3195.6 3243.0 3284.0 3295.3 3394.0 536888.0 541023.0 542123.0 547404.0 548072.0 53404.5 63411.0 63609.7 63686.4 63771.4 34778.8 35243.6 35703.3 36480.8 36675.4 17268.8 17405.0 17412.5 17521.7 17532.3 11123.8 13141.9 13309.4 13316.5 13323.5 19543.0 19567.0 19855.3 19876.0 19895.5 7649.5 7807.7 7829.3 7850.6 7911.2 857.2 914.2 953.4 959.6 1063.5 25039.5 29813.4 30544.1 30845.7 31146.8 913.3 1055.6 1071.6 1096.9 1125.8 15681.1 15863.4 15977.4 16027.3 16270.8 707795.0 717045.0 718956.0 721349.0 721543.0 59295.0 59533.0 59745.8 59845.4 59877.7 1344.3 1346.8 1374.4 1377.6 1382.4 24474.0 29224.6 29755.9 30032.5 31072.7 54510.7 57686.8 58353.4 58384.7 58508.0 647712.0 650739.0 650818.0 656598.0 657838.0 43887.0 44529.9 44540.0 44725.6 44955.3 48807.0 49196.5 49202.8 49918.8 50465.5 39373.6 39774.2 40246.8 40868.8 41602.0 32477.5 37827.4 39643.4 39883.0 41185.0 33539.0 33545.0 37178.8 39144.6 39515.4 29103.4 33454.5 35838.3 35905.6 36037.8 26225.7 26248.0 26493.7 26675.1 27145.6 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36133.83 Median:2143.73 stddev:105495.59 (4921.1%) stddev-sans-first:105757.27 16:29:52 INFO - PROCESS | 1666 | Values: 327.0 329.2 387.4 389.0 405.5 19293.9 19585.9 20334.4 20893.7 21128.8 19627.4 19895.5 19930.3 20100.3 20333.8 5175.3 5738.5 5884.0 6130.9 6147.6 5912.4 6069.8 6069.8 6070.9 6079.8 5938.7 6032.8 6034.6 6634.4 6704.9 5624.8 5640.3 6677.7 6688.6 6721.2 5583.2 5776.6 5825.1 5831.9 5846.2 12502.2 12878.2 12923.0 18341.7 24711.6 2084.5 2142.0 2145.5 2262.7 2420.9 9923.9 9993.2 10091.8 10179.3 13728.9 1866.4 1885.8 1912.3 1949.8 1953.5 128987.0 130349.0 130900.3 133226.0 133687.3 9065.3 11432.9 11547.5 11619.4 11805.8 14396.1 14427.6 14441.3 14456.3 14464.3 8538.1 8576.7 8606.5 8646.0 8721.2 8537.4 8564.7 8614.7 8624.7 8743.3 4465.5 4483.9 4493.5 4498.3 4551.8 1906.4 1914.6 1933.7 1937.5 1977.6 820.3 943.8 977.2 1016.5 1027.9 20183.4 20410.7 20486.4 20684.4 20749.2 922.8 935.5 947.9 966.4 1004.8 10639.1 10801.7 10847.3 10863.5 10960.2 620013.0 623316.0 634462.0 635314.0 643572.0 102378.0 106185.5 122952.4 146162.0 146282.0 873.6 885.8 971.3 994.0 1023.6 15151.8 18530.8 18934.4 18946.7 18956.6 47903.8 54152.5 58293.0 58651.4 59392.8 77473.2 83683.6 84192.6 85276.4 85434.0 6895.9 7994.8 8009.7 8058.6 8093.9 10362.8 11227.0 12551.6 12736.7 12922.4 10336.9 10821.2 10854.9 10908.8 11213.9 10611.5 10811.2 10853.1 10991.1 11063.9 10772.4 11022.2 11191.7 11528.4 11581.5 7418.2 7574.3 7719.2 7901.9 7919.2 9737.3 10532.9 10581.6 10865.5 11033.2 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5829.26 Median:4899.13 stddev:3311.90 (67.6%) stddev-sans-first:3305.13 16:29:52 INFO - PROCESS | 1666 | Values: 1489.6 1493.1 1730.4 1848.7 1889.6 8164.8 8447.4 8674.7 9269.6 9285.0 8752.7 9064.3 9079.0 9153.4 9162.9 1939.6 2403.8 2414.0 2452.8 2454.4 2346.9 2416.3 2419.0 2423.4 2433.3 2422.6 2425.1 2426.0 2432.6 2440.1 2406.8 2407.4 2419.6 2422.4 2431.2 2350.1 2383.7 2384.9 2391.1 2395.9 8989.2 9046.8 9078.8 9114.1 9119.5 5381.7 5526.6 5563.7 5566.1 5586.2 3610.3 3661.0 3668.4 3675.7 3720.2 1047.9 1068.5 1068.8 1080.5 1089.3 12001.2 12001.8 12147.4 12222.8 12224.0 4860.2 4873.8 4903.7 5001.4 5003.9 10342.0 10446.3 10455.1 10460.9 10488.6 5545.9 5562.7 5568.2 5568.4 5598.3 4521.9 4646.1 4900.8 5035.9 5082.1 4069.0 4069.9 4160.0 4203.2 4269.2 1111.5 1119.7 1312.4 1320.3 1328.4 670.7 843.3 901.6 912.4 923.1 4897.5 5569.9 5692.2 5947.8 6202.9 428.3 432.4 448.4 455.5 462.9 3431.7 4035.1 4037.8 4075.9 4083.1 9844.9 10741.9 10780.2 10995.9 11076.7 10839.8 11011.5 11129.8 11144.4 11156.2 8381.5 8505.1 8516.8 8529.1 8547.3 5824.4 5916.6 6066.3 6067.4 6126.4 9514.4 10289.2 10343.2 10392.9 10410.9 8337.8 9948.2 10417.3 10588.6 10596.5 5984.5 7353.4 7597.6 7726.3 8181.7 8519.4 8623.9 8687.0 8764.0 8791.8 6533.5 7560.4 7670.5 7685.9 7724.6 7431.4 7460.6 7543.2 7631.7 7695.9 6858.4 7185.4 7277.1 7297.7 7311.9 5016.0 5043.2 5145.7 5253.8 5288.5 5012.6 5048.6 5123.5 5131.6 5173.9 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4734.86 Median:5084.22 stddev:1509.39 (29.7%) stddev-sans-first:1476.67 16:29:52 INFO - PROCESS | 1666 | Values: 312.3 315.0 318.9 324.1 325.2 5141.3 5496.4 5649.0 5652.7 5704.4 4740.5 5400.2 5617.6 5651.9 5689.3 3998.3 4257.7 4273.8 4313.9 4324.4 3797.0 4082.2 4224.3 4230.5 4362.9 3924.0 4275.9 4287.2 4292.7 4295.2 3902.5 3905.5 4167.4 4214.7 4336.4 3291.7 3327.9 3449.8 3499.7 3560.9 5045.8 5107.6 5116.0 5425.3 5523.3 4613.8 4757.9 5013.6 5037.0 5062.6 4845.9 5363.0 5645.8 5972.3 6027.5 3312.4 3679.8 4097.8 4107.6 4125.8 6203.8 6316.3 6335.6 6385.5 6395.2 4043.9 4187.6 4225.2 4230.3 4250.8 3923.9 4257.3 4259.5 4259.9 4322.9 4369.9 4463.9 4522.4 5007.0 5032.0 4915.7 5017.8 5732.4 6061.0 6110.8 1258.9 1345.7 1401.4 1435.4 1470.1 825.7 840.0 884.7 906.3 908.8 4324.9 4337.7 4407.9 4500.4 4710.5 4513.8 4530.9 4695.0 4988.5 5263.1 4060.3 4356.6 4512.0 4656.0 4860.6 2486.8 2636.8 2728.0 2924.7 3227.7 6466.9 6502.4 6520.8 6528.7 6531.6 5463.9 5694.0 5973.8 6404.6 6445.4 5860.5 6002.2 6539.4 6546.9 6554.7 5861.6 6022.0 6135.3 6288.4 6301.3 5051.9 5113.6 5773.4 5963.4 6179.0 6508.6 6559.6 6561.4 6563.2 6571.0 3957.6 4065.0 4075.6 4086.9 4112.8 5470.4 5817.7 5823.2 6184.6 6229.3 5123.0 5517.3 5563.7 5724.3 6055.8 5216.8 5244.7 5957.3 5995.6 6003.4 5687.4 5952.5 5962.9 5978.3 5979.9 5105.8 5804.3 5940.0 5952.1 6034.0 4916.8 5858.8 5898.9 5911.8 5931.0 16:29:52 INFO - PROCESS | 1666 | 16:29:52 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:24900.91 Median:3661.05 stddev:40300.08 (1100.8%) stddev-sans-first:40372.18 16:29:52 INFO - PROCESS | 1666 | Values: 702.8 706.7 777.2 791.4 809.0 15394.3 15524.5 15701.8 15801.4 15834.0 14262.6 14274.4 14287.1 14296.0 14388.6 674.7 696.9 835.5 835.6 852.5 852.4 856.9 857.6 857.9 860.0 860.6 909.4 917.8 920.9 923.1 917.8 919.5 920.3 923.3 931.0 676.0 682.5 684.4 684.8 685.8 14704.3 14942.6 14990.2 15025.2 15030.8 14691.7 14700.9 14724.3 14771.6 14866.3 11298.2 11535.4 11588.1 11646.4 12058.1 3705.9 3797.2 3831.9 3846.7 3857.0 101298.0 108587.5 112739.4 113311.0 125149.0 11259.9 11318.9 11413.9 11417.4 11694.5 17857.0 22147.8 23760.8 23773.2 23781.9 7153.6 8173.2 8206.8 8272.5 8416.1 3674.5 4408.2 4429.9 4563.9 4578.4 3647.6 3778.6 3779.2 3781.0 3792.4 619.5 619.9 627.4 632.0 654.5 649.0 653.3 675.9 683.8 697.6 9014.2 9593.9 9621.9 9641.9 9761.3 626.9 637.3 640.7 664.9 673.8 4738.6 4749.6 4751.5 4752.9 4754.0 103994.0 104107.0 104972.2 163237.2 174506.0 143257.0 143586.0 143917.0 145960.0 147913.0 78897.6 81735.0 89613.0 124452.4 128127.4 8935.3 9066.3 9103.2 9131.9 9347.9 68377.3 68419.7 69526.6 70034.3 70624.6 87552.1 101628.0 105800.0 108026.5 108747.0 9748.5 11804.8 11964.4 11998.9 12361.3 12147.0 12316.9 12385.2 12542.2 12568.4 11845.9 11932.2 12231.3 12420.8 12747.7 12077.1 12211.9 12304.9 12347.5 12625.9 11770.4 11788.5 12171.9 12217.8 12593.1 10358.9 10384.7 10437.7 10685.7 10823.4 10362.2 10518.4 10550.9 10554.9 10563.6 16:29:52 INFO - PROCESS | 1666 | -------- Summary: end -------- 16:29:52 INFO - PROCESS | 1666 | 16:29:53 INFO - TEST-INFO | 1666: exit 0 16:29:53 INFO - TEST-OK | dromaeo_css | took 1113037ms 16:29:53 INFO - TEST-START | kraken 16:29:53 INFO - operating with platform_type : mac_ 16:29:53 INFO - Initialising browser for kraken test... 16:29:53 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmppuIUUY/profile http://localhost:49277/getInfo.html) 16:29:56 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 16:29:56 INFO - PROCESS | 1674 | colorDepth:24 16:29:56 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 16:29:56 INFO - PROCESS | 1674 | __metrics 16:29:56 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:29:56 INFO - TEST-INFO | 1674: exit 0 16:29:56 INFO - Browser initialized. 16:29:56 INFO - Running cycle 1/1 for kraken test... 16:29:56 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmppuIUUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:08 INFO - PROCESS | 1676 | RSS: Main: 224931840 16:30:08 INFO - PROCESS | 1676 | 16:30:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:12 INFO - PROCESS | 1676 | RSS: Main: 237449216 16:30:12 INFO - PROCESS | 1676 | 16:30:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 16:30:16 INFO - PROCESS | 1676 | RSS: Main: 244858880 16:30:16 INFO - PROCESS | 1676 | 16:30:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 16:30:20 INFO - PROCESS | 1676 | RSS: Main: 246685696 16:30:20 INFO - PROCESS | 1676 | 16:30:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 16:30:22 INFO - PROCESS | 1676 | RSS: Main: 248406016 16:30:22 INFO - PROCESS | 1676 | 16:30:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:25 INFO - PROCESS | 1676 | RSS: Main: 248725504 16:30:25 INFO - PROCESS | 1676 | 16:30:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:28 INFO - PROCESS | 1676 | RSS: Main: 248926208 16:30:28 INFO - PROCESS | 1676 | 16:30:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:32 INFO - PROCESS | 1676 | RSS: Main: 250372096 16:30:32 INFO - PROCESS | 1676 | 16:30:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 16:30:36 INFO - PROCESS | 1676 | RSS: Main: 250597376 16:30:36 INFO - PROCESS | 1676 | 16:30:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:38 INFO - PROCESS | 1676 | RSS: Main: 250224640 16:30:38 INFO - PROCESS | 1676 | 16:30:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:41 INFO - PROCESS | 1676 | RSS: Main: 250281984 16:30:41 INFO - PROCESS | 1676 | 16:30:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:43 INFO - PROCESS | 1676 | RSS: Main: 250368000 16:30:43 INFO - PROCESS | 1676 | 16:30:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:47 INFO - PROCESS | 1676 | RSS: Main: 250761216 16:30:47 INFO - PROCESS | 1676 | 16:30:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:51 INFO - PROCESS | 1676 | RSS: Main: 250699776 16:30:51 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 16:30:53 INFO - PROCESS | 1676 | RSS: Main: 252071936 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | __start_tp_report 16:30:53 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 16:30:53 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 16:30:53 INFO - PROCESS | 1676 | |i|pagename|runs| 16:30:53 INFO - PROCESS | 1676 | |0;ai-astar;105;119;118;121;137;161;119;117;146;176 16:30:53 INFO - PROCESS | 1676 | |1;audio-beat-detection;146;107;111;139;112;113;112;113;136;110 16:30:53 INFO - PROCESS | 1676 | |2;audio-dft;281;250;194;192;197;257;282;196;220;202 16:30:53 INFO - PROCESS | 1676 | |3;audio-fft;79;57;58;105;78;82;73;49;94;51 16:30:53 INFO - PROCESS | 1676 | |4;audio-oscillator;86;71;87;72;70;94;125;99;86;94 16:30:53 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;86;89;86;88;93;118;87;91;86 16:30:53 INFO - PROCESS | 1676 | |6;imaging-darkroom;134;112;99;98;136;147;172;99;103;126 16:30:53 INFO - PROCESS | 1676 | |7;imaging-desaturate;95;94;90;91;100;144;135;92;86;92 16:30:53 INFO - PROCESS | 1676 | |8;json-parse-financial;55;54;55;55;59;57;58;58;57;62 16:30:53 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;66;68;73;79;116;64;98;86;57;62 16:30:53 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;85;84;92;103;100;85;83;85;83;85 16:30:53 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;141;151;154;156;137;138;134;140;240;143 16:30:53 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;165;164;176;212;229;191;166;164;164;165 16:30:53 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;93;89;89;89;90;74;67;66;68 16:30:53 INFO - PROCESS | 1676 | __end_tp_report 16:30:53 INFO - PROCESS | 1676 | __start_cc_report 16:30:53 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,959 16:30:53 INFO - PROCESS | 1676 | __end_cc_report 16:30:53 INFO - PROCESS | 1676 | __startTimestamp1475710253292__endTimestamp 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | ------- Summary: start ------- 16:30:53 INFO - PROCESS | 1676 | Number of tests: 14 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:131.90 Median:129.00 stddev:22.62 (17.5%) stddev-sans-first:21.80 16:30:53 INFO - PROCESS | 1676 | Values: 105.0 119.0 118.0 121.0 137.0 161.0 119.0 117.0 146.0 176.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:113.00 stddev:14.41 (12.8%) stddev-sans-first:11.79 16:30:53 INFO - PROCESS | 1676 | Values: 146.0 107.0 111.0 139.0 112.0 113.0 112.0 113.0 136.0 110.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:227.10 Median:235.00 stddev:36.85 (15.7%) stddev-sans-first:33.52 16:30:53 INFO - PROCESS | 1676 | Values: 281.0 250.0 194.0 192.0 197.0 257.0 282.0 196.0 220.0 202.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:72.60 Median:75.50 stddev:18.70 (24.8%) stddev-sans-first:19.69 16:30:53 INFO - PROCESS | 1676 | Values: 79.0 57.0 58.0 105.0 78.0 82.0 73.0 49.0 94.0 51.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:86.50 stddev:16.46 (19.0%) stddev-sans-first:17.44 16:30:53 INFO - PROCESS | 1676 | Values: 86.0 71.0 87.0 72.0 70.0 94.0 125.0 99.0 86.0 94.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:88.00 stddev:9.69 (11.0%) stddev-sans-first:10.21 16:30:53 INFO - PROCESS | 1676 | Values: 88.0 86.0 89.0 86.0 88.0 93.0 118.0 87.0 91.0 86.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:122.60 Median:159.50 stddev:24.88 (15.6%) stddev-sans-first:26.05 16:30:53 INFO - PROCESS | 1676 | Values: 134.0 112.0 99.0 98.0 136.0 147.0 172.0 99.0 103.0 126.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:91.50 stddev:20.25 (22.1%) stddev-sans-first:21.32 16:30:53 INFO - PROCESS | 1676 | Values: 95.0 94.0 90.0 91.0 100.0 144.0 135.0 92.0 86.0 92.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.50 stddev:2.40 (4.2%) stddev-sans-first:2.44 16:30:53 INFO - PROCESS | 1676 | Values: 55.0 54.0 55.0 55.0 59.0 57.0 58.0 58.0 57.0 62.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:70.50 stddev:18.44 (26.2%) stddev-sans-first:19.13 16:30:53 INFO - PROCESS | 1676 | Values: 66.0 68.0 73.0 79.0 116.0 64.0 98.0 86.0 57.0 62.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.00 stddev:7.34 (8.6%) stddev-sans-first:7.67 16:30:53 INFO - PROCESS | 1676 | Values: 85.0 84.0 92.0 103.0 100.0 85.0 83.0 85.0 83.0 85.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:147.00 stddev:31.33 (21.3%) stddev-sans-first:32.91 16:30:53 INFO - PROCESS | 1676 | Values: 141.0 151.0 154.0 156.0 137.0 138.0 134.0 140.0 240.0 143.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:171.00 stddev:23.51 (13.7%) stddev-sans-first:24.34 16:30:53 INFO - PROCESS | 1676 | Values: 165.0 164.0 176.0 212.0 229.0 191.0 166.0 164.0 164.0 165.0 16:30:53 INFO - PROCESS | 1676 | 16:30:53 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:89.00 stddev:11.76 (13.2%) stddev-sans-first:11.48 16:30:53 INFO - PROCESS | 1676 | Values: 66.0 93.0 89.0 89.0 89.0 90.0 74.0 67.0 66.0 68.0 16:30:53 INFO - PROCESS | 1676 | -------- Summary: end -------- 16:30:53 INFO - PROCESS | 1676 | 16:30:54 INFO - TEST-INFO | 1676: exit 0 16:30:54 INFO - TEST-OK | kraken | took 60505ms 16:30:54 INFO - SUITE-END | took 1173s 16:30:54 INFO - Completed test suite (00:19:33) 16:30:54 INFO - javascript benchmark 16:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7449.702324996745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2946.9263268418285, 3455.9827200863992, 3459.2389674271667, 3477.843497042633, 3501.9649803501975, 4577.542245775429, 5876.382979787119, 5948.7620495180145, 5961.433663801938, 5962.552808539355, 5895.292564892208, 5983.700814959257, 6005.789797357093, 6006.219191505098, 6020.698965051752, 5286.894262114765, 5401.4868587484325, 5414.648047876875, 5432.049391356497, 5459.945400545984, 4455.598996090367, 5416.322959630046, 5418.133098704208, 5454.972725136368, 5484.588655850807, 5316.415194328621, 5325.094733895227, 5415.729213539327, 5417.133258678612, 5436.21174929637, 5339.199120131972, 5342.679439233659, 5391.16436952273, 5453.972730136324, 5483.8080667176855, 5257.211418287249, 5374.4894235048, 5378.865528361822, 5399.811006614749, 5479.397266300703, 4214.810333534998, 5819.854503637401, 6029.487493563052, 6082.908756368658, 6087.726052327655, 4839.879003024917, 6051.636901785907, 6097.359777223416, 6203.0, 6372.968135159341, 5862.601770963318, 6089.451949324538, 6351.87296254077, 6391.328910464381, 6411.134496842913, 6115.510759139258, 6131.50947924165, 6134.69326533676, 6142.477889379453, 6144.2319710036245, 6276.278228003746, 6351.460125889259, 6365.172527571386, 6392.616443013434, 6438.6136831790245, 6216.875662486725, 6257.155284036597, 6267.435930766253, 6271.059341098871, 6274.435300822948, 6395.0, 6396.328385519547, 6396.5202609804455, 6403.839904002437, 6427.132337134427, 6186.845328866724, 6203.689815509207, 6206.348333424925, 6236.594621349598, 6237.688115594202, 6259.71831267594, 6280.466160376328, 6309.873802523924, 6337.017762246859, 6349.365063493706, 5078.873028174326, 5085.1355269604255, 5095.210242412432, 5097.898042039138, 5119.360079990001, 4411.22803509391, 4470.798814053375, 4500.009997800478, 4547.13309047359, 4595.862124136282, 6112.358202388774, 6115.755369785248, 6134.0, 6152.316563929193, 6171.228596425447, 6391.872162556723, 6410.0, 6423.903641445382, 6425.935740642627, 6498.480121590356, 5998.970005150034, 6069.302030266487, 6069.393060693984, 6115.51416190291, 6172.4136207060255, 4779.641526885497, 5622.184783206412, 5631.958087753778, 5651.0, 5671.234383358276, 6251.906221406683, 6592.077109204811, 6616.437602803816, 6651.368120028589, 6662.233843108104, 6189.1025801257665, 6249.843753906189, 6273.027680709497, 6401.64790936503, 6489.448396886129, 6502.4472919800455, 6618.371254730793, 6621.668916554249, 6649.168853893263, 6651.50113741481, 6311.526635502448, 6311.652859092794, 6318.6840657965995, 6318.894193516025, 6348.650824204528, 6063.575549711478, 6242.406971337716, 6326.272478664829, 6354.4598709108395, 6367.42693157618, 5131.281620573197, 6145.217886812953, 6155.076738489262, 6202.5658203925295, 6251.499880009679, 6221.657808820558, 6232.937670623236, 6236.937630623635, 6239.563230573816, 6332.905006425, 5537.947128278309, 6028.788992385245, 6057.697115144313, 6109.205803245727, 6147.231596050494, 6132.998044146438, 6165.537584681257, 6173.259208894781, 6220.968895155676, 6253.499720022296, 6092.329843717276, 6128.019516877278, 6142.109394137736, 6167.167432396569, 6238.189035425366], "value": 5824.540570962163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.35824882537685, 488.2968525323534, 498.4865588443902, 529.6133822309716, 543.0496630895932, 41930.742077737676, 42616.9345766356, 42633.78683106584, 44584.55415445845, 44595.77702111493, 40711.0, 44282.55717442824, 44732.77633611827, 44744.552554474445, 44850.551494485044, 7812.101608315045, 8189.672413103469, 9925.205983521337, 9926.45404502752, 9934.304598678096, 9696.660616878411, 9781.168600668952, 9826.606935722562, 9829.164521015686, 9842.557084931195, 8386.496810191407, 9800.117989380955, 9841.655542056029, 9845.803083938317, 9860.556274967608, 9761.219102471785, 9800.068993445611, 9816.803663926752, 9820.754481137958, 9838.557264923023, 8228.711995080203, 8394.748157555283, 9751.219902407862, 9799.461029643368, 9812.607495700164, 41815.372769408175, 41983.37024944598, 42078.57921420777, 42209.57790422118, 42241.788791056155, 3332.8333583320737, 3360.0, 3469.8612055517747, 3549.964500354989, 3565.983694647013, 31495.685043149504, 31679.366412671618, 31775.841120794248, 31784.523232151536, 32134.196645083826, 3195.568598239231, 3243.0, 3284.014795561322, 3295.3244584860045, 3394.01573543672, 536888.0, 541023.0, 542123.0, 547404.0, 548071.999999996, 53404.465955340725, 63411.04883426752, 63609.68195158995, 63686.36313636897, 63771.36228637654, 34778.82610586981, 35243.64756352455, 35703.28593428117, 36480.817595912384, 36675.449868252, 17268.827311726724, 17405.042722650123, 17412.47762567125, 17521.7371739424, 17532.298708051534, 11123.833142502868, 13141.868581314257, 13309.40107695156, 13316.533921312708, 13323.533676321282, 19543.0, 19567.0, 19855.30506432297, 19876.006199689957, 19895.502612434517, 7649.464537482323, 7807.69998005182, 7829.256220659028, 7850.56821874791, 7911.208879112158, 857.1728282207699, 914.2320450821342, 953.3612479638658, 959.6353385713384, 1063.505469956474, 25039.499210015696, 29813.403731925675, 30544.08367748971, 30845.69154308473, 31146.844265778527, 913.2967614936462, 1055.630529314749, 1071.614218881202, 1096.857408536901, 1125.8254970479588, 15681.137537435323, 15863.365465381255, 15977.360905563879, 16027.278772455034, 16270.83729162717, 707795.0, 717045.0, 718956.0, 721349.0, 721543.0, 59295.0, 59533.0, 59745.80508389808, 59845.40154598485, 59877.700611496664, 1344.2942455210896, 1346.7912473566612, 1374.4364810427676, 1377.6142680049602, 1382.3710211853381, 24474.0, 29224.561631575118, 29755.851220743756, 30032.549511756904, 31072.689273107884, 54510.727446362514, 57686.84626307366, 58353.4164658348, 58384.70807645935, 58508.0, 647712.0, 650739.0, 650818.0, 656598.0, 657838.0, 43887.0, 44529.88675283144, 44540.0, 44725.55274447214, 44955.32567011432, 48807.0, 49196.50803491919, 49202.753986229836, 49918.75040624774, 50465.49534504608, 39373.62192323255, 39774.204515910096, 40246.79876600598, 40868.79565602153, 41602.0, 32477.51283730793, 37827.432588510645, 39643.405348919216, 39883.0, 41185.0, 33538.993830185136, 33545.0, 37178.8141059293, 39144.608553915234, 39515.40726889041, 29103.417931640826, 33454.49818252777, 35838.283234335686, 35905.64094359023, 36037.81981090078, 26225.73774262233, 26247.950081996507, 26493.735062649128, 26675.06637267686, 27145.59281610738], "value": 20461.508770682813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9542264083028, 329.2328873724221, 387.38405934564037, 388.97471664341833, 405.4546634776225, 19293.903530482363, 19585.902070489647, 20334.389968300973, 20893.686594701092, 21128.788712112873, 19627.411177664657, 19895.502612434695, 19930.302439414587, 20100.296489622866, 20333.796662033375, 5175.275461435402, 5738.454846789548, 5883.970580147104, 6130.877382452349, 6147.631142131464, 5912.408759124075, 6069.817905462821, 6069.817905462844, 6070.878582428349, 6079.817605471821, 5938.673372964486, 6032.849178770522, 6034.577579569432, 6634.402903738663, 6704.865902681943, 5624.803131890364, 5640.266765320503, 6677.699503522304, 6688.565243259197, 6721.193456785192, 5583.218349431083, 5776.566757493205, 5825.097109947922, 5831.912521312183, 5846.239988801429, 12502.187357821804, 12878.162919410208, 12922.966162707055, 18341.7248741269, 24711.62932556013, 2084.530980529384, 2141.957160856774, 2145.5065334972887, 2262.7058482397347, 2420.9394765130837, 9923.851142232872, 9993.150582200522, 10091.79816403675, 10179.338343007756, 13728.93135534316, 1866.3747644539096, 1885.764279465067, 1912.3211260002777, 1949.83426408754, 1953.5018570264633, 128987.0, 130349.0, 130900.34549827286, 133226.0, 133687.33156334254, 9065.320100992452, 11432.942835285936, 11547.538098475967, 11619.419029048513, 11805.763884722257, 14396.064255823338, 14427.567172984827, 14441.277936103153, 14456.27718614065, 14464.27678616086, 8538.146185381536, 8576.742697719079, 8606.483610983236, 8646.0, 8721.17148870869, 8537.402381833337, 8564.700235491728, 8614.698485552975, 8624.706294055817, 8743.300535957109, 4465.4864690561, 4483.865484035484, 4493.528179541101, 4498.280275155959, 4551.817927282872, 1906.428071578521, 1914.5596512802133, 1933.6712758831034, 1937.5156210947264, 1977.5550501137416, 820.306840719591, 943.8159558885951, 977.2231076294363, 1016.466355163545, 1027.8715160604925, 20183.39449816508, 20410.69383959242, 20486.38540843777, 20684.379468615967, 20749.1700331985, 922.7761095759188, 935.4995077633433, 947.8862536495527, 966.3766870368573, 1004.8191325561469, 10639.148868090535, 10801.73374613003, 10847.288676236076, 10863.52226053894, 10960.232783705063, 620013.0, 623316.0, 634462.0, 635314.0, 643572.0, 102378.0, 106185.46907265414, 122952.38523807324, 146162.0, 146282.0, 873.6418068591973, 885.8051228729669, 971.3443425687633, 994.0, 1023.5803320638652, 15151.772723408938, 18530.81469185291, 18934.43196704101, 18946.715799262747, 18956.620867582846, 47903.84432700607, 54152.45847541474, 58293.0, 58651.4134858663, 59392.81214375602, 77473.22526774886, 83683.5815820917, 84192.57903710687, 85276.4417067489, 85434.0, 6895.862182739792, 7994.84010319802, 8009.679612815422, 8058.597070146352, 8093.878591821245, 10362.844557331797, 11227.0, 12551.623451296477, 12736.6815829605, 12922.353882306035, 10336.948315258676, 10821.242513024014, 10854.945725271638, 10908.836367454336, 11213.943930280297, 10611.469426528489, 10811.24321297533, 10853.131749460183, 10991.120710342993, 11063.889361106287, 10772.407517586607, 11022.173336999596, 11191.66425007251, 11528.365939873387, 11581.478833452684, 7418.221086786026, 7574.3183113520045, 7719.189485103983, 7901.9032723893915, 7919.16848730898, 9737.269704772028, 10532.89467105319, 10581.576736930436, 10865.456727163451, 11033.227674062739], "value": 9493.145133276206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.6424858034072, 1493.0593725952651, 1730.420309196419, 1848.6857234270174, 1889.5559543507272, 8164.7550573482895, 8447.408681392306, 8674.653013879446, 9269.629214831399, 9285.0, 8752.737417877457, 9064.27485801136, 9078.954605226965, 9153.359264851462, 9162.86255706165, 1939.6411663842234, 2403.8076953843693, 2413.987930060356, 2452.8405653632544, 2454.410941374066, 2346.9413264668433, 2416.347586151738, 2418.9758102419014, 2423.3941514621347, 2433.3429973907037, 2422.648715936197, 2425.139075628153, 2425.963610545843, 2432.586460301753, 2440.0727723465147, 2406.819488538367, 2407.434252950555, 2419.6491508731224, 2422.406510404962, 2431.197704757426, 2350.059976009593, 2383.690120284352, 2384.8807559622123, 2391.1391898916377, 2395.9035843636816, 8989.190972812477, 9046.81906361869, 9078.818423631556, 9114.088591140899, 9119.49842758648, 5381.650192737459, 5526.640768350045, 5563.749631266603, 5566.081596536566, 5586.162075688639, 3610.332088563598, 3660.981695091534, 3668.394714872043, 3675.72432067596, 3720.2373513429684, 1047.8899715529913, 1068.4871261794383, 1068.7541865370931, 1080.4867687848289, 1089.319175515303, 12001.159918805688, 12001.759964800742, 12147.392630368446, 12222.816657750142, 12224.02207823381, 4860.1737704590305, 4873.756312184377, 4903.730294833747, 5001.399832020181, 5003.924941125886, 10342.0, 10446.320989135835, 10455.059044686015, 10460.947695261475, 10488.580456781796, 5545.916811247835, 5562.721863906789, 5568.220449137124, 5568.387477377485, 5598.272224610774, 4521.88695282614, 4646.094011667692, 4900.803967841318, 5035.874103147451, 5082.059818933509, 4068.959310406917, 4069.8575549856205, 4160.043190066242, 4203.243416185055, 4269.167512335065, 1111.4609414433994, 1119.7480566872389, 1312.3700623700677, 1320.306838909561, 1328.435414948643, 670.6646676661669, 843.3379796859435, 901.6348378906554, 912.4251721415466, 923.0907556057278, 4897.461279259279, 5569.860753481114, 5692.2330000892325, 5947.762089516457, 6202.875942481125, 428.32752578451533, 432.4486279993034, 448.4013841521605, 455.535353938987, 462.9328747331618, 3431.742619303562, 4035.092104276573, 4037.7981100944835, 4075.91848163041, 4083.060895993938, 9844.9015509844, 10741.892581074246, 10780.245382823126, 10995.9004099591, 11076.667699969013, 10839.783204335869, 11011.504482298316, 11129.833052504218, 11144.387058711687, 11156.219064665396, 8381.455205411628, 8505.064442911274, 8516.787080322918, 8529.061803201643, 8547.316214702809, 5824.417558244311, 5916.585838991229, 6066.302375226729, 6067.393260673897, 6126.356732543019, 9514.429134251966, 10289.228307876789, 10343.224258180517, 10392.948035260079, 10410.895891040993, 8337.83324333522, 9948.154406875206, 10417.322874013165, 10588.629397971343, 10596.47017649099, 5984.461398474158, 7353.411727061715, 7597.582132982739, 7726.304632583095, 8181.67273309061, 8519.403641745019, 8623.913760862311, 8686.956565217133, 8764.035956044958, 8791.824163516821, 6533.542652014504, 7560.357369623423, 7670.501417407851, 7685.923140768745, 7724.613769311624, 7431.442641801778, 7460.626968651654, 7543.245675432632, 7631.69473221065, 7695.923040769745, 6858.41703455192, 7185.389241914496, 7277.126744790659, 7297.671604777904, 7311.8903216450735, 5015.996800639814, 5043.218301163325, 5145.677630790155, 5253.842384728464, 5288.524032837063, 5012.573931215888, 5048.570871475818, 5123.538881500683, 5131.563817075441, 5173.922391164211], "value": 4582.180270560331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.25682874758076, 314.99999999999983, 318.905922752788, 324.1361770880603, 325.1967639929375, 5141.305923700304, 5496.395396506381, 5649.039663257246, 5652.745626446809, 5704.429557044294, 4740.4548476925165, 5400.216968539569, 5617.550595952324, 5651.9152212716845, 5689.301953730078, 3998.280309544281, 4257.6806739494505, 4273.807678654468, 4313.870583882489, 4324.351347297915, 3796.9937966438915, 4082.2243773682903, 4224.281872081738, 4230.4500414946015, 4362.934555981663, 3924.038610540422, 4275.850345237917, 4287.1854347674, 4292.699511034229, 4295.165190973958, 3902.5170435234713, 3905.511811023622, 4167.395727619493, 4214.714512073816, 4336.371226172203, 3291.670832916713, 3327.900162995114, 3449.844756985942, 3499.6850283474355, 3560.946585801215, 5045.798168073273, 5107.61692873036, 5116.002379535992, 5425.321834770653, 5523.28197334344, 4613.792379342937, 4757.9286310705365, 5013.615809328725, 5037.028153389481, 5062.594992400599, 4845.903081938377, 5363.0, 5645.834061833418, 5972.343042265347, 6027.47392775227, 3312.3706495765728, 3679.8344074516713, 4097.774622395767, 4107.630313271819, 4125.792700905032, 6203.7828675996125, 6316.30520642729, 6335.619862808247, 6385.541566496886, 6395.16862807832, 4043.939340909889, 4187.597154953125, 4225.176090662291, 4230.323148296319, 4250.787460626956, 3923.8614954849677, 4257.318828987409, 4259.467566554181, 4259.893502662396, 4322.891927701832, 4369.919206959086, 4463.888402789891, 4522.389477420506, 5006.974965125151, 5032.0, 4915.705057696549, 5017.799288028511, 5732.398098199712, 6060.969695151496, 6110.816675499742, 1258.924464532131, 1345.7039451320693, 1401.4254155796075, 1435.4473527691705, 1470.0885451020436, 825.6779855856221, 839.9668407858246, 884.7478468636408, 906.2840356118725, 908.8364094462928, 4324.913501729948, 4337.72965846498, 4407.867763967086, 4500.4149460569915, 4710.528947105262, 4513.751743654065, 4530.886727831765, 4694.976525117421, 4988.503448965296, 5263.131593281671, 4060.2894493463527, 4356.564343565618, 4511.954880451219, 4655.976720116378, 4860.586850117709, 2486.813488988333, 2636.7890568754456, 2727.986360068187, 2924.692907244751, 3227.708916433445, 6466.870662586722, 6502.382273684087, 6520.836979075466, 6528.673566321665, 6531.575447595891, 5463.879904619623, 5694.0, 5973.802791571361, 6404.647744374011, 6445.41991220783, 5860.454425072855, 6002.219711437485, 6539.444147247537, 6546.919758239837, 6554.721829243252, 5861.648301101947, 6021.952536137735, 6135.294441139147, 6288.434040936338, 6301.338359472373, 5051.87370315745, 5113.565346945551, 5773.422657734193, 5963.4334738199805, 6179.0145356244075, 6508.60948343082, 6559.573627714183, 6561.392458847613, 6563.195121341479, 6570.967145164243, 3957.584453632327, 4065.0, 4075.573549257736, 4086.897827554335, 4112.773797441169, 5470.370907345547, 5817.738201781015, 5823.194809609035, 6184.5980011299125, 6229.314775374796, 5123.001014802227, 5517.282753242213, 5563.666180029211, 5724.255846739898, 6055.819115272656, 5216.791328346823, 5244.737763111752, 5957.344692083954, 5995.591036106599, 6003.369646187088, 5687.402822703722, 5952.5237980960555, 5962.940370596412, 5978.312494063064, 5979.850503737442, 5105.846824595268, 5804.332501762183, 5940.0, 5952.0797050753645, 6033.969830150997, 4916.778744956414, 5858.765649374148, 5898.94101058984, 5911.788083442798, 5930.970345148246], "value": 4252.113360805046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.7856503766352, 706.6678661029317, 777.1684297801352, 791.4459878085335, 808.9959550202248, 15394.307256173472, 15524.456644017462, 15701.764473532907, 15801.446949356761, 15834.0, 14262.643433914158, 14274.4290228391, 14287.071340362869, 14296.0, 14388.640283992905, 674.6930146783226, 696.923338432772, 835.5446281776447, 835.6239692138547, 852.4544291653347, 852.40757673417, 856.9228769410752, 857.5540718826206, 857.9356548258875, 859.9871001934976, 860.5826174305457, 909.3634455880876, 917.8026724254285, 920.8756817829608, 923.0584803500426, 917.8118485710413, 919.4758987377197, 920.3051695969567, 923.3213588012806, 930.9906900930972, 676.0298970976664, 682.4915437998723, 684.4148253243504, 684.8287928017995, 685.7634116229892, 14704.264786760727, 14942.551723448314, 14990.175540345277, 15025.248737563079, 15030.849691503163, 14691.706165876623, 14700.852991470056, 14724.263786810616, 14771.556853294418, 14866.256687165707, 11298.209125361229, 11535.423228838608, 11588.072954163647, 11646.359450230233, 12058.095642826824, 3705.8517659293866, 3797.1836055247977, 3831.9042023949346, 3846.7307288489815, 3857.0164608025057, 101297.97404051878, 108587.45706271497, 112739.43630281878, 113311.0, 125149.0, 11259.887401125883, 11318.94340528292, 11413.942930285462, 11417.429128543707, 11694.532218711327, 17857.0, 22147.778522214572, 23760.7623923762, 23773.167939122046, 23781.881090594783, 7153.570785752768, 8173.18268173178, 8206.794830129174, 8272.503649781032, 8416.074231834493, 3674.4855720199193, 4408.162449134654, 4429.911401771947, 4563.863084107482, 4578.381918440968, 3647.6170002149925, 3778.6032466590614, 3779.244151169777, 3780.981095094507, 3792.355299599075, 619.454879705856, 619.9411055949768, 627.3726273726273, 631.962082275065, 654.4927681047132, 648.9578177418452, 653.3335997282745, 675.9459243260527, 683.8427161752825, 697.6197972105215, 9014.18872301483, 9593.904060959301, 9621.9037809621, 9641.903580964241, 9761.267904907161, 626.9216347956506, 637.2639601260552, 640.6892657061321, 664.9135612370361, 673.8147009572309, 4738.64460165489, 4749.572538471554, 4751.477337492873, 4752.904941901143, 4753.976230118897, 103994.0, 104107.0, 104972.2385005802, 163237.18381408017, 174506.0, 143257.0, 143586.0, 143917.0, 145960.0, 147913.0, 78897.60551197322, 81735.0, 89613.0, 124452.42154416796, 128127.35936320445, 8935.329850261127, 9066.274698024274, 9103.226225770619, 9131.908680913106, 9347.859782103138, 68377.31622683909, 68419.65790171018, 69526.5665701698, 70034.29965700278, 70624.64687676734, 87552.1244787544, 101628.0, 105800.0, 108026.4598677033, 108747.0, 9748.463834489172, 11804.822927656263, 11964.401779911144, 11998.940005299917, 12361.258324500559, 12147.0, 12316.938415307866, 12385.19496232742, 12542.24746515212, 12568.371581421075, 11845.940770296093, 11932.22440541362, 12231.327276999851, 12420.813687794871, 12747.681307967376, 12077.076754527166, 12211.938940305241, 12304.938475307566, 12347.506099755909, 12625.87374126247, 11770.411479425824, 11788.4695188715, 12171.878281217074, 12217.755644887231, 12593.055520835791, 10358.896411036094, 10384.740381490523, 10437.68686939393, 10685.732856678645, 10823.350598964087, 10362.222833287382, 10518.421486818299, 10550.947245263724, 10554.947225263824, 10563.63027294041], "value": 7753.582149555551, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 118.0, 121.0, 137.0, 161.0, 119.0, 117.0, 146.0, 176.0], "value": 131.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 111.0, 139.0, 112.0, 113.0, 112.0, 113.0, 136.0, 110.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [281.0, 250.0, 194.0, 192.0, 197.0, 257.0, 282.0, 196.0, 220.0, 202.0], "value": 227.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 105.0, 78.0, 82.0, 73.0, 49.0, 94.0, 51.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 87.0, 72.0, 70.0, 94.0, 125.0, 99.0, 86.0, 94.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 93.0, 118.0, 87.0, 91.0, 86.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 112.0, 99.0, 98.0, 136.0, 147.0, 172.0, 99.0, 103.0, 126.0], "value": 122.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 90.0, 91.0, 100.0, 144.0, 135.0, 92.0, 86.0, 92.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 59.0, 57.0, 58.0, 58.0, 57.0, 62.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 73.0, 79.0, 116.0, 64.0, 98.0, 86.0, 57.0, 62.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 92.0, 103.0, 100.0, 85.0, 83.0, 85.0, 83.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 151.0, 154.0, 156.0, 137.0, 138.0, 134.0, 140.0, 240.0, 143.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 176.0, 212.0, 229.0, 191.0, 166.0, 164.0, 164.0, 165.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 93.0, 89.0, 89.0, 89.0, 90.0, 74.0, 67.0, 66.0, 68.0], "value": 79.1, "unit": "score"}]}]} 16:30:54 INFO - Return code: 0 16:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:30:54 ERROR - # TBPL SUCCESS # 16:30:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:30:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:30:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:30:54 INFO - 2016-10-05 16:30:54.648 screenresolution[1682:11333] starting screenresolution argv=screenresolution get 16:30:54 INFO - 2016-10-05 16:30:54.651 screenresolution[1682:11333] Display 0: 1600x1200x32@60 16:30:54 INFO - 2016-10-05 16:30:54.657 screenresolution[1683:11336] starting screenresolution argv=screenresolution list 16:30:54 INFO - Available Modes on Display 0 16:30:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:30:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:30:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:30:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:30:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:30:54 INFO - Intel Iris: 16:30:54 INFO - Chipset Model: Intel Iris 16:30:54 INFO - Type: GPU 16:30:54 INFO - Bus: Built-In 16:30:54 INFO - VRAM (Dynamic, Max): 1536 MB 16:30:54 INFO - Vendor: Intel (0x8086) 16:30:54 INFO - Device ID: 0x0a2e 16:30:54 INFO - Revision ID: 0x0009 16:30:54 INFO - Displays: 16:30:54 INFO - Display: 16:30:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:30:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:30:54 INFO - Display Serial Number: 1600x1200 60 16:30:54 INFO - Main Display: Yes 16:30:54 INFO - Mirror: Off 16:30:54 INFO - Online: Yes 16:30:54 INFO - Rotation: Supported 16:30:54 INFO - Return code: 0 16:30:54 INFO - Running post-action listener: _resource_record_post_action 16:30:54 INFO - [mozharness: 2016-10-05 23:30:54.891972Z] Finished run-tests step (success) 16:30:54 INFO - Running post-run listener: _resource_record_post_run 16:30:54 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 33123328; Write bytes: 666997248; Read time: 313; Write time: 2272 16:30:54 INFO - TinderboxPrint: CPU usage
54.3% 16:30:54 INFO - TinderboxPrint: I/O read bytes / time
33,123,328 / 313 16:30:54 INFO - TinderboxPrint: I/O write bytes / time
666,997,248 / 2,272 16:30:54 INFO - TinderboxPrint: CPU idle
2,206.7 (45.7%) 16:30:54 INFO - TinderboxPrint: CPU system
974.7 (20.2%) 16:30:54 INFO - TinderboxPrint: CPU user
1,644.4 (34.1%) 16:30:54 INFO - TinderboxPrint: Swap in / out
392,597,504 / 0 16:30:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362367488; Write bytes: 357705728; Read time: 27703; Write time: 671 16:30:54 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29293568; Write bytes: 298899968; Read time: 284; Write time: 1570 16:30:55 INFO - Running post-run listener: _upload_blobber_files 16:30:55 INFO - Blob upload gear active. 16:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:55 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:30:55 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:30:55 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:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:57 INFO - (blobuploader) - INFO - Done attempting. 16:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:58 INFO - (blobuploader) - INFO - Done attempting. 16:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:00 INFO - (blobuploader) - INFO - Done attempting. 16:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:00 INFO - Return code: 0 16:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b907b816f28d60f21cf75bf20426b187de183f8669fc415e5ac12427e9b3e2013a78ef7907263264725941695b57c53aeb4c14d8a52df21ab801d4c5fd94333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5518d63c61235e9490f1efc9af64cae6a43a01fd47fe445335e29395a003b944a621b157e8396d1aba65a0e7ead3659ffbdd41198dbcdeb9889e27754c6540b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98677c3ae5790d930c0afb871b25e0de88f937b83258da5b9fbae48992062b1a74c5fc76d1f614ff6abfa00c1a05c4a164189de44d4f300387302365a146fff5"} 16:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:00 INFO - Contents: 16:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b907b816f28d60f21cf75bf20426b187de183f8669fc415e5ac12427e9b3e2013a78ef7907263264725941695b57c53aeb4c14d8a52df21ab801d4c5fd94333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5518d63c61235e9490f1efc9af64cae6a43a01fd47fe445335e29395a003b944a621b157e8396d1aba65a0e7ead3659ffbdd41198dbcdeb9889e27754c6540b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98677c3ae5790d930c0afb871b25e0de88f937b83258da5b9fbae48992062b1a74c5fc76d1f614ff6abfa00c1a05c4a164189de44d4f300387302365a146fff5"} 16:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:00 INFO - Copying logs to upload dir... 16:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.559009 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-05 16:31:00.688845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 16:31:00.696318) ========= 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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b907b816f28d60f21cf75bf20426b187de183f8669fc415e5ac12427e9b3e2013a78ef7907263264725941695b57c53aeb4c14d8a52df21ab801d4c5fd94333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5518d63c61235e9490f1efc9af64cae6a43a01fd47fe445335e29395a003b944a621b157e8396d1aba65a0e7ead3659ffbdd41198dbcdeb9889e27754c6540b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98677c3ae5790d930c0afb871b25e0de88f937b83258da5b9fbae48992062b1a74c5fc76d1f614ff6abfa00c1a05c4a164189de44d4f300387302365a146fff5"} build_url:https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010905 build_url: 'https://queue.taskcluster.net/v1/task/Z649HyWVTgifcGjHYJoYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b907b816f28d60f21cf75bf20426b187de183f8669fc415e5ac12427e9b3e2013a78ef7907263264725941695b57c53aeb4c14d8a52df21ab801d4c5fd94333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5518d63c61235e9490f1efc9af64cae6a43a01fd47fe445335e29395a003b944a621b157e8396d1aba65a0e7ead3659ffbdd41198dbcdeb9889e27754c6540b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98677c3ae5790d930c0afb871b25e0de88f937b83258da5b9fbae48992062b1a74c5fc76d1f614ff6abfa00c1a05c4a164189de44d4f300387302365a146fff5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 16:31:00.730916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:31:00.731211) ========= 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.Vbqse4Kurk/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.JD2CgSWhLK/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005026 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 16:31:00.779439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 16:31:00.779726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 16:31:00.783039) ========= ========= Total master_lag: 0.21 =========