builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0251 starttime: 1476289129.32 results: success (0) buildid: 20161012070646 builduid: 291c6bf99ec7454ca95ba9e4da3e9ec2 revision: 1047827ed4d37a7c91411d645dea6f1deaa984c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.320137) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.320581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.320867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.344137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.344684) ========= 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.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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-12 09:18:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 131M=0s 2016-10-12 09:18:49 (131 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.475193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.475587) ========= 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.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.020935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:49.526422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 09:18:49.527066) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1047827ed4d37a7c91411d645dea6f1deaa984c0 --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 1047827ed4d37a7c91411d645dea6f1deaa984c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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-12 09:18:49,608 truncating revision to first 12 chars 2016-10-12 09:18:49,609 Setting DEBUG logging. 2016-10-12 09:18:49,609 attempt 1/10 2016-10-12 09:18:49,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1047827ed4d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 09:18:50,495 unpacking tar archive at: mozilla-aurora-1047827ed4d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 09:18:50.715044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:50.715443) ========= script_repo_revision: 1047827ed4d37a7c91411d645dea6f1deaa984c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:50.715882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:50.716150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 09:18:50.735552) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-12 09:18:50.736013) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:18:50 INFO - MultiFileLogger online at 20161012 09:18:50 in /builds/slave/test 09:18:50 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 09:18:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:50 INFO - {'append_to_log': False, 09:18:50 INFO - 'base_work_dir': '/builds/slave/test', 09:18:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:18:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:50 INFO - 'branch': 'Mozilla-Aurora', 09:18:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:50 INFO - 'config_files': ('talos/mac_config.py',), 09:18:50 INFO - 'default_actions': ('clobber', 09:18:50 INFO - 'read-buildbot-config', 09:18:50 INFO - 'download-and-extract', 09:18:50 INFO - 'populate-webroot', 09:18:50 INFO - 'create-virtualenv', 09:18:50 INFO - 'install', 09:18:50 INFO - 'run-tests'), 09:18:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:50 INFO - 'download_minidump_stackwalk': True, 09:18:50 INFO - 'download_symbols': 'ondemand', 09:18:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:50 INFO - 'installer_path': 'installer.exe', 09:18:50 INFO - 'log_level': 'info', 09:18:50 INFO - 'log_name': 'talos', 09:18:50 INFO - 'log_to_console': True, 09:18:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:50 INFO - 'opt_config_files': (), 09:18:50 INFO - 'pip_index': False, 09:18:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:50 INFO - 'cmd': ('bash', 09:18:50 INFO - '-c', 09:18:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:50 INFO - 'enabled': True, 09:18:50 INFO - 'halt_on_failure': False, 09:18:50 INFO - 'name': 'check_screen_resolution'},), 09:18:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:50 INFO - 'cmd': ('bash', 09:18:50 INFO - '-c', 09:18:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:50 INFO - 'enabled': True, 09:18:50 INFO - 'halt_on_failure': False, 09:18:50 INFO - 'name': 'check_screen_resolution'},), 09:18:50 INFO - 'run_cmd_checks_enabled': True, 09:18:50 INFO - 'sps_profile': False, 09:18:50 INFO - 'sps_profile_interval': 0, 09:18:50 INFO - 'suite': 'dromaeojs-e10s', 09:18:50 INFO - 'system_bits': '32', 09:18:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:50 INFO - 'title': 't-yosemite-r7-0251', 09:18:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:50 INFO - 'use_talos_json': True, 09:18:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:50 INFO - 'work_dir': 'build'} 09:18:50 INFO - [mozharness: 2016-10-12 16:18:50.929005Z] Running clobber step. 09:18:50 INFO - Running pre-action listener: _resource_record_pre_action 09:18:50 INFO - Running main action method: clobber 09:18:50 INFO - rmtree: /builds/slave/test/build 09:18:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:52 INFO - Running post-action listener: _resource_record_post_action 09:18:52 INFO - [mozharness: 2016-10-12 16:18:52.517988Z] Finished clobber step (success) 09:18:52 INFO - [mozharness: 2016-10-12 16:18:52.518177Z] Running read-buildbot-config step. 09:18:52 INFO - Running pre-action listener: _resource_record_pre_action 09:18:52 INFO - Running main action method: read_buildbot_config 09:18:52 INFO - Using buildbot properties: 09:18:52 INFO - { 09:18:52 INFO - "project": "", 09:18:52 INFO - "product": "firefox", 09:18:52 INFO - "script_repo_revision": "production", 09:18:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:18:52 INFO - "repository": "", 09:18:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:18:52 INFO - "buildid": "20161012070646", 09:18:52 INFO - "pgo_build": "False", 09:18:52 INFO - "basedir": "/builds/slave/test", 09:18:52 INFO - "buildnumber": 23, 09:18:52 INFO - "slavename": "t-yosemite-r7-0251", 09:18:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:18:52 INFO - "platform": "yosemite_r7", 09:18:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:18:52 INFO - "branch": "mozilla-aurora", 09:18:52 INFO - "repo_path": "releases/mozilla-aurora", 09:18:52 INFO - "revision": "1047827ed4d37a7c91411d645dea6f1deaa984c0", 09:18:52 INFO - "stage_platform": "macosx64", 09:18:52 INFO - "builduid": "291c6bf99ec7454ca95ba9e4da3e9ec2", 09:18:52 INFO - "slavebuilddir": "test" 09:18:52 INFO - } 09:18:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:18:52 INFO - Running post-action listener: _resource_record_post_action 09:18:52 INFO - [mozharness: 2016-10-12 16:18:52.526130Z] Finished read-buildbot-config step (success) 09:18:52 INFO - [mozharness: 2016-10-12 16:18:52.526317Z] Running download-and-extract step. 09:18:52 INFO - Running pre-action listener: _resource_record_pre_action 09:18:52 INFO - Running main action method: download_and_extract 09:18:52 INFO - mkdir: /builds/slave/test/build/tests 09:18:52 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')]} 09:18:52 INFO - trying https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/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 09:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/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 09:18:53 INFO - Downloaded 1199 bytes. 09:18:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:18:53 INFO - Using the following test package requirements: 09:18:53 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:18:53 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:18:53 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:18:53 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'jsshell-mac.zip'], 09:18:53 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:18:53 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:18:53 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:18:53 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:18:53 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:18:53 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:53 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:18:53 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:18:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:18:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:18:53 INFO - Fetch https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:18:54 INFO - Expected file size: 16435034 09:19:01 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 09:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:19:02 INFO - Expected file size: 16435034 09:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:19:09 INFO - Expected file size: 14414059 09:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:10 INFO - trying https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:10 INFO - Downloading https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/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 09:19:13 INFO - Downloaded 115369785 bytes. 09:19:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:13 INFO - mkdir: /builds/slave/test/properties 09:19:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:13 INFO - Contents: 09:19:13 INFO - build_url:https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - Running post-action listener: set_extra_try_arguments 09:19:14 INFO - [mozharness: 2016-10-12 16:19:14.083108Z] Finished download-and-extract step (success) 09:19:14 INFO - [mozharness: 2016-10-12 16:19:14.083262Z] Running populate-webroot step. 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: populate_webroot 09:19:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:14 INFO - '--tppagecycles', 09:19:14 INFO - '7'], 09:19:14 INFO - 'tests': ['tsvgm']}}, 09:19:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['basic_compositor_video']}, 09:19:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart']}, 09:19:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart']}, 09:19:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o']}, 09:19:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['tp5o']}, 09:19:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s', 09:19:14 INFO - '--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}, 09:19:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}}, 09:19:14 INFO - 'talos.zip': {'path': '', 09:19:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - [mozharness: 2016-10-12 16:19:14.102106Z] Finished populate-webroot step (success) 09:19:14 INFO - [mozharness: 2016-10-12 16:19:14.102238Z] Running create-virtualenv step. 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: create_virtualenv 09:19:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:14 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 09:19:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:14 INFO - Using real prefix '/tools/python27' 09:19:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:17 INFO - Installing pip.................done. 09:19:17 INFO - Return code: 0 09:19:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:17 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 09:19:17 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 09:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:17 INFO - 'HOME': '/Users/cltbld', 09:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:17 INFO - 'LOGNAME': 'cltbld', 09:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:17 INFO - 'MOZ_NO_REMOTE': '1', 09:19:17 INFO - 'NO_EM_RESTART': '1', 09:19:17 INFO - 'PAGER': '/bin/cat', 09:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:17 INFO - 'PWD': '/builds/slave/test', 09:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:17 INFO - 'SHELL': '/bin/bash', 09:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:17 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:17 INFO - 'USER': 'cltbld', 09:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:17 INFO - 'XPC_FLAGS': '0x0', 09:19:17 INFO - 'XPC_SERVICE_NAME': '0', 09:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:18 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 09:19:18 INFO - Cleaning up... 09:19:18 INFO - Return code: 0 09:19:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:18 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')]} 09:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:18 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')]} 09:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:18 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:18 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 09:19:18 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 09:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:18 INFO - 'HOME': '/Users/cltbld', 09:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:18 INFO - 'LOGNAME': 'cltbld', 09:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:18 INFO - 'MOZ_NO_REMOTE': '1', 09:19:18 INFO - 'NO_EM_RESTART': '1', 09:19:18 INFO - 'PAGER': '/bin/cat', 09:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:18 INFO - 'PWD': '/builds/slave/test', 09:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:18 INFO - 'SHELL': '/bin/bash', 09:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:18 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:18 INFO - 'USER': 'cltbld', 09:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:18 INFO - 'XPC_FLAGS': '0x0', 09:19:18 INFO - 'XPC_SERVICE_NAME': '0', 09:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:18 INFO - Downloading/unpacking psutil>=3.1.1 09:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:21 INFO - Installing collected packages: psutil 09:19:21 INFO - Running setup.py install for psutil 09:19:21 INFO - building 'psutil._psutil_osx' extension 09:19:21 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 09:19:21 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 09:19:22 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 09:19:22 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 09:19:22 INFO - building 'psutil._psutil_posix' extension 09:19:22 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 09:19:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:19:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:19:22 INFO - ^ 09:19:22 INFO - 1 warning generated. 09:19:22 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 09:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:22 INFO - Successfully installed psutil 09:19:22 INFO - Cleaning up... 09:19:22 INFO - Return code: 0 09:19:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:22 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:22 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 09:19:22 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 09:19:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:22 INFO - 'HOME': '/Users/cltbld', 09:19:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:22 INFO - 'LOGNAME': 'cltbld', 09:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:22 INFO - 'MOZ_NO_REMOTE': '1', 09:19:22 INFO - 'NO_EM_RESTART': '1', 09:19:22 INFO - 'PAGER': '/bin/cat', 09:19:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:22 INFO - 'PWD': '/builds/slave/test', 09:19:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:22 INFO - 'SHELL': '/bin/bash', 09:19:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:22 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:22 INFO - 'USER': 'cltbld', 09:19:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:22 INFO - 'XPC_FLAGS': '0x0', 09:19:22 INFO - 'XPC_SERVICE_NAME': '0', 09:19:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:22 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 09:19:22 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 09:19:22 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 09:19:22 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 09:19:22 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 09:19:22 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 09:19:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:25 INFO - Installing collected packages: mozsystemmonitor 09:19:25 INFO - Running setup.py install for mozsystemmonitor 09:19:25 INFO - Successfully installed mozsystemmonitor 09:19:25 INFO - Cleaning up... 09:19:25 INFO - Return code: 0 09:19:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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', '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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19: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 jsonschema==2.5.1 09:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:25 INFO - 'HOME': '/Users/cltbld', 09:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:25 INFO - 'LOGNAME': 'cltbld', 09:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:25 INFO - 'MOZ_NO_REMOTE': '1', 09:19:25 INFO - 'NO_EM_RESTART': '1', 09:19:25 INFO - 'PAGER': '/bin/cat', 09:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:25 INFO - 'PWD': '/builds/slave/test', 09:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:25 INFO - 'SHELL': '/bin/bash', 09:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:25 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:25 INFO - 'USER': 'cltbld', 09:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:25 INFO - 'XPC_FLAGS': '0x0', 09:19:25 INFO - 'XPC_SERVICE_NAME': '0', 09:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:28 INFO - warning: no files found matching '*.txt' 09:19:28 INFO - no previously-included directories found matching 'build' 09:19:28 INFO - no previously-included directories found matching 'dist' 09:19:28 INFO - no previously-included directories found matching '.git*' 09:19:28 INFO - Installing collected packages: jsonschema, functools32 09:19:28 INFO - Running setup.py install for functools32 09:19:28 INFO - warning: no files found matching '*.txt' 09:19:28 INFO - no previously-included directories found matching 'build' 09:19:28 INFO - no previously-included directories found matching 'dist' 09:19:28 INFO - no previously-included directories found matching '.git*' 09:19:29 INFO - Successfully installed jsonschema functools32 09:19:29 INFO - Cleaning up... 09:19:29 INFO - Return code: 0 09:19:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:29 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')]} 09:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 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')]} 09:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:29 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 09:19:29 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 09:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:29 INFO - 'HOME': '/Users/cltbld', 09:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:29 INFO - 'LOGNAME': 'cltbld', 09:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:29 INFO - 'MOZ_NO_REMOTE': '1', 09:19:29 INFO - 'NO_EM_RESTART': '1', 09:19:29 INFO - 'PAGER': '/bin/cat', 09:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:29 INFO - 'PWD': '/builds/slave/test', 09:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:29 INFO - 'SHELL': '/bin/bash', 09:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:29 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:29 INFO - 'USER': 'cltbld', 09:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:29 INFO - 'XPC_FLAGS': '0x0', 09:19:29 INFO - 'XPC_SERVICE_NAME': '0', 09:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:29 INFO - Cleaning up... 09:19:29 INFO - Return code: 0 09:19:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:29 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')]} 09:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 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')]} 09:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:29 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 09:19:29 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 09:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:29 INFO - 'HOME': '/Users/cltbld', 09:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:29 INFO - 'LOGNAME': 'cltbld', 09:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:29 INFO - 'MOZ_NO_REMOTE': '1', 09:19:29 INFO - 'NO_EM_RESTART': '1', 09:19:29 INFO - 'PAGER': '/bin/cat', 09:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:29 INFO - 'PWD': '/builds/slave/test', 09:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:29 INFO - 'SHELL': '/bin/bash', 09:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:29 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:29 INFO - 'USER': 'cltbld', 09:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:29 INFO - 'XPC_FLAGS': '0x0', 09:19:29 INFO - 'XPC_SERVICE_NAME': '0', 09:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:29 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:33 INFO - Downloading docopt-0.6.1.tar.gz 09:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:33 INFO - Running setup.py install for blobuploader 09:19:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:33 INFO - Running setup.py install for requests 09:19:34 INFO - Running setup.py install for docopt 09:19:34 INFO - Successfully installed blobuploader requests docopt 09:19:34 INFO - Cleaning up... 09:19:34 INFO - Return code: 0 09:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:34 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')]} 09:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:34 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')]} 09:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:34 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:34 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 09:19:34 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 09:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:34 INFO - 'HOME': '/Users/cltbld', 09:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:34 INFO - 'LOGNAME': 'cltbld', 09:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:34 INFO - 'MOZ_NO_REMOTE': '1', 09:19:34 INFO - 'NO_EM_RESTART': '1', 09:19:34 INFO - 'PAGER': '/bin/cat', 09:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:34 INFO - 'PWD': '/builds/slave/test', 09:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:34 INFO - 'SHELL': '/bin/bash', 09:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:34 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:34 INFO - 'USER': 'cltbld', 09:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:34 INFO - 'XPC_FLAGS': '0x0', 09:19:34 INFO - 'XPC_SERVICE_NAME': '0', 09:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-BYmIAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-dmQAi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-7ghCLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-f5GIqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-JbF_vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-sGiwnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-y9B7cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-OP6gKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-cAxjod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-kpcGge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-rdBI3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-FKj4mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-9KyVVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-aHcl00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_WkYQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-84hFAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-VOKFys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:36 INFO - Running setup.py install for manifestparser 09:19:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozcrash 09:19:36 INFO - Running setup.py install for mozdebug 09:19:36 INFO - Running setup.py install for mozdevice 09:19:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozfile 09:19:37 INFO - Running setup.py install for mozhttpd 09:19:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozinfo 09:19:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozInstall 09:19:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozleak 09:19:37 INFO - Running setup.py install for mozlog 09:19:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for moznetwork 09:19:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozprocess 09:19:38 INFO - Running setup.py install for mozprofile 09:19:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozrunner 09:19:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozscreenshot 09:19:38 INFO - Running setup.py install for moztest 09:19:38 INFO - Running setup.py install for mozversion 09:19:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:38 INFO - Cleaning up... 09:19:38 INFO - Return code: 0 09:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:38 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')]} 09:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 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')]} 09:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:38 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 09:19:38 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 09:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:38 INFO - 'HOME': '/Users/cltbld', 09:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:38 INFO - 'LOGNAME': 'cltbld', 09:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:38 INFO - 'MOZ_NO_REMOTE': '1', 09:19:38 INFO - 'NO_EM_RESTART': '1', 09:19:38 INFO - 'PAGER': '/bin/cat', 09:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:38 INFO - 'PWD': '/builds/slave/test', 09:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:38 INFO - 'SHELL': '/bin/bash', 09:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:38 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:38 INFO - 'USER': 'cltbld', 09:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:38 INFO - 'XPC_FLAGS': '0x0', 09:19:38 INFO - 'XPC_SERVICE_NAME': '0', 09:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-ReuhVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-BVvkdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-zNx7ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-uziA6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-EDMFnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-CvIhWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-UEtOwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-WDrzjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-6_BDqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-2lSN6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-qlEhXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-D7icWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Rcd2HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-orDkPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-XM8uRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-k16U7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-HAhUbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:43 INFO - Downloading blessings-1.6.tar.gz 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:43 INFO - Installing collected packages: blessings 09:19:43 INFO - Running setup.py install for blessings 09:19:43 INFO - Successfully installed blessings 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Current package versions: 09:19:44 INFO - blessings == 1.6 09:19:44 INFO - blobuploader == 1.2.4 09:19:44 INFO - docopt == 0.6.1 09:19:44 INFO - functools32 == 3.2.3-2 09:19:44 INFO - jsonschema == 2.5.1 09:19:44 INFO - manifestparser == 1.1 09:19:44 INFO - mozInstall == 1.12 09:19:44 INFO - mozcrash == 0.17 09:19:44 INFO - mozdebug == 0.1 09:19:44 INFO - mozdevice == 0.48 09:19:44 INFO - mozfile == 1.2 09:19:44 INFO - mozhttpd == 0.7 09:19:44 INFO - mozinfo == 0.9 09:19:44 INFO - mozleak == 0.1 09:19:44 INFO - mozlog == 3.4 09:19:44 INFO - moznetwork == 0.27 09:19:44 INFO - mozprocess == 0.23 09:19:44 INFO - mozprofile == 0.28 09:19:44 INFO - mozrunner == 6.12 09:19:44 INFO - mozscreenshot == 0.1 09:19:44 INFO - mozsystemmonitor == 0.3 09:19:44 INFO - moztest == 0.7 09:19:44 INFO - mozversion == 1.4 09:19:44 INFO - psutil == 3.1.1 09:19:44 INFO - requests == 1.2.3 09:19:44 INFO - wsgiref == 0.1.2 09:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:44 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')]} 09:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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')]} 09:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:44 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 09:19:44 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 09:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:44 INFO - 'HOME': '/Users/cltbld', 09:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:44 INFO - 'LOGNAME': 'cltbld', 09:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:44 INFO - 'MOZ_NO_REMOTE': '1', 09:19:44 INFO - 'NO_EM_RESTART': '1', 09:19:44 INFO - 'PAGER': '/bin/cat', 09:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:44 INFO - 'PWD': '/builds/slave/test', 09:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:44 INFO - 'SHELL': '/bin/bash', 09:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:44 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:44 INFO - 'USER': 'cltbld', 09:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:44 INFO - 'XPC_FLAGS': '0x0', 09:19:44 INFO - 'XPC_SERVICE_NAME': '0', 09:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 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)) 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:44 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')]} 09:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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')]} 09:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:44 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 0x10cae7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b579480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, '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.fnYtE3IHPN/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.fImOtABccD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:19:44 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 09:19:44 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 09:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:44 INFO - 'HOME': '/Users/cltbld', 09:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:44 INFO - 'LOGNAME': 'cltbld', 09:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:44 INFO - 'MOZ_NO_REMOTE': '1', 09:19:44 INFO - 'NO_EM_RESTART': '1', 09:19:44 INFO - 'PAGER': '/bin/cat', 09:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:44 INFO - 'PWD': '/builds/slave/test', 09:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:44 INFO - 'SHELL': '/bin/bash', 09:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:19:44 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:44 INFO - 'USER': 'cltbld', 09:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:44 INFO - 'XPC_FLAGS': '0x0', 09:19:44 INFO - 'XPC_SERVICE_NAME': '0', 09:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Running post-action listener: _resource_record_post_action 09:19:44 INFO - Running post-action listener: _start_resource_monitoring 09:19:44 INFO - Starting resource monitoring. 09:19:44 INFO - [mozharness: 2016-10-12 16:19:44.713334Z] Finished create-virtualenv step (success) 09:19:44 INFO - [mozharness: 2016-10-12 16:19:44.714368Z] Running install step. 09:19:44 INFO - Running pre-action listener: _resource_record_pre_action 09:19:44 INFO - Running main action method: install 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:45 INFO - Reading from file tmpfile_stdout 09:19:45 INFO - Output received: 09:19:45 INFO - Usage: mozinstall [options] installer 09:19:45 INFO - Options: 09:19:45 INFO - -h, --help show this help message and exit 09:19:45 INFO - -d DEST, --destination=DEST 09:19:45 INFO - Directory to install application into. [default: 09:19:45 INFO - "/builds/slave/test"] 09:19:45 INFO - --app=APP Application being installed. [default: firefox] 09:19:45 INFO - mkdir: /builds/slave/test/build/application 09:19:45 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'] 09:19:45 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 09:20:17 INFO - Reading from file tmpfile_stdout 09:20:17 INFO - Output received: 09:20:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2016-10-12 16:20:17.426686Z] Finished install step (success) 09:20:17 INFO - [mozharness: 2016-10-12 16:20:17.426853Z] Running run-tests step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: run_tests 09:20:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:17 INFO - 2016-10-12 09:20:17.441 screenresolution[1922:18035] starting screenresolution argv=screenresolution get 09:20:17 INFO - 2016-10-12 09:20:17.444 screenresolution[1922:18035] Display 0: 1600x1200x32@60 09:20:17 INFO - 2016-10-12 09:20:17.449 screenresolution[1923:18037] starting screenresolution argv=screenresolution list 09:20:17 INFO - Available Modes on Display 0 09:20:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:17 INFO - Intel Iris: 09:20:17 INFO - Chipset Model: Intel Iris 09:20:17 INFO - Type: GPU 09:20:17 INFO - Bus: Built-In 09:20:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:17 INFO - Vendor: Intel (0x8086) 09:20:17 INFO - Device ID: 0x0a2e 09:20:17 INFO - Revision ID: 0x0009 09:20:17 INFO - Displays: 09:20:17 INFO - Display: 09:20:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:17 INFO - Display Serial Number: 1600x1200 60 09:20:17 INFO - Main Display: Yes 09:20:17 INFO - Mirror: Off 09:20:17 INFO - Online: Yes 09:20:17 INFO - Rotation: Supported 09:20:17 INFO - Return code: 0 09:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:17 INFO - Python 2.7.3 09:20:17 INFO - Return code: 0 09:20:17 INFO - grabbing minidump binary from tooltool 09:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:17 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 0x10c8fbd30>, '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 0x10c761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:17 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 09:20:17 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 09:20:17 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 09:20:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:17 INFO - Return code: 0 09:20:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:20:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:20:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:17 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/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 09:20:17 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/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0251 --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 09:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fnYtE3IHPN/Render', 09:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:17 INFO - 'HOME': '/Users/cltbld', 09:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:17 INFO - 'LOGNAME': 'cltbld', 09:20:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:17 INFO - 'MOZ_NO_REMOTE': '1', 09:20:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'NO_EM_RESTART': '1', 09:20:17 INFO - 'PAGER': '/bin/cat', 09:20:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:17 INFO - 'PWD': '/builds/slave/test', 09:20:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:17 INFO - 'SHELL': '/bin/bash', 09:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fImOtABccD/Listeners', 09:20:17 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:17 INFO - 'USER': 'cltbld', 09:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:17 INFO - 'XPC_FLAGS': '0x0', 09:20:17 INFO - 'XPC_SERVICE_NAME': '0', 09:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:17 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/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 09:20:18 INFO - mozversion application_buildid: 20161012070646 09:20:18 INFO - mozversion application_changeset: 1047827ed4d37a7c91411d645dea6f1deaa984c0 09:20:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:20:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:18 INFO - mozversion application_name: Firefox 09:20:18 INFO - mozversion application_remotingname: firefox-dev 09:20:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:18 INFO - mozversion application_vendor: Mozilla 09:20:18 INFO - mozversion application_version: 51.0a2 09:20:18 INFO - mozversion platform_buildid: 20161012070646 09:20:18 INFO - mozversion platform_changeset: 1047827ed4d37a7c91411d645dea6f1deaa984c0 09:20:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:18 INFO - mozversion platform_version: 51.0a2 09:20:18 INFO - using testdate: 1476289218 09:20:18 INFO - actual date: 1476289218 09:20:18 INFO - starting webserver on 'localhost:53104' 09:20:18 INFO - SUITE-START | Running 2 tests 09:20:18 INFO - TEST-START | dromaeo_css 09:20:18 INFO - operating with platform_type : mac_ 09:20:18 INFO - Initialising browser for dromaeo_css test... 09:20:18 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpzwtcKZ/profile http://localhost:53104/getInfo.html) 09:20:20 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 09:20:20 INFO - PROCESS | 1933 | colorDepth:24 09:20:20 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 09:20:20 INFO - PROCESS | 1933 | __metrics 09:20:20 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:20:21 INFO - TEST-INFO | 1933: exit 0 09:20:21 INFO - Browser initialized. 09:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:21 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpzwtcKZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:33 INFO - PROCESS | 1936 | RSS: Main: 224854016 09:20:33 INFO - PROCESS | 1936 | 09:21:23 INFO - PROCESS | 1936 | 1476289283052 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] 09:23:34 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53104/tests/dromaeo/cssquery-ext.html) 09:23:36 INFO - PROCESS | 1936 | RSS: Main: 237547520 09:23:36 INFO - PROCESS | 1936 | 09:26:38 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-ext.html (next: http://localhost:53104/tests/dromaeo/cssquery-jquery.html) 09:26:39 INFO - PROCESS | 1936 | RSS: Main: 248967168 09:26:39 INFO - PROCESS | 1936 | 09:29:41 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53104/tests/dromaeo/cssquery-mootools.html) 09:29:41 INFO - PROCESS | 1936 | RSS: Main: 251232256 09:29:41 INFO - PROCESS | 1936 | 09:32:43 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53104/tests/dromaeo/cssquery-prototype.html) 09:32:44 INFO - PROCESS | 1936 | RSS: Main: 251510784 09:32:44 INFO - PROCESS | 1936 | 09:35:47 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53104/tests/dromaeo/cssquery-yui.html) 09:35:47 INFO - PROCESS | 1936 | RSS: Main: 256057344 09:35:47 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53104/tests/dromaeo/cssquery-yui.html (next: http://localhost:53104/tests/dromaeo/cssquery-dojo.html) 09:38:50 INFO - PROCESS | 1936 | RSS: Main: 258498560 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | __start_tp_report 09:38:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 09:38:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 09:38:50 INFO - PROCESS | 1936 | |i|pagename|runs| 09:38:50 INFO - PROCESS | 1936 | |0;dojo.html;3399.1841957930105;3404.3021180657965;3446.465797801341;3451.5512983312165;3455.1707590178366;5825.300963884334;5846.181534585156;5875.118732190173;5885.234919460475;5894.145348924409;5855.063189889618;5903.586748927577;5923.229980102591;5956.076808094752;6002.6998650067435;5316.548093412064;5384.0847056000575;5402.513773760361;5415.025295446818;5473.932583146288;5397.62216644835;5422;5423.620346575742;5438.972805135989;5442.564594832404;5299.5230429261355;5307.203919412081;5422.213779002062;5423.3491980962335;5440.319960004999;5295.894082118355;5353.652012619187;5357.08929481989;5363.222332761728;5416.241726158341;5217.47825217479;5309.814156504543;5311.9468805311835;5331.920021199685;5338.893222135574;4984.0281145176705;5880.705964701748;5899.46904778572;5981.371955944606;5991.790287339966;6088.726007329681;6111.014442317695;6159.938400615982;6188.009918413078;6251.249850017982;4801.759912004421;5784.971075144597;6017.428344307284;6285.0886621440095;6287.371262873722;4485.977570112162;5154.948450515484;5840.211571437886;5971.104334349882;5971.820845374646;6189.690515474208;6252.249730032425;6260.655663938436;6306;6311.368863113652;5150.768215430315;5800.926828536734;6190.659513726789;6247.656378899113;6273;5706.28671416073;6195.349488303754;6265.4361107500545;6271.686415679198;6283.6858157091965;5150.304708864255;6128.258691089361;6147.801178770186;6174.228221472316;6205.472534834499;5686.77252909879;6206;6218.19163508741;6234.75060997555;6237.126802247689;5017.949820501748;5021.59827213822;5030.0945829751;5041.69749815005;5053.267276244997;4432.445944256968;4440.62254708347;4444.777761111932;4505.459344878635;4510.594046535827;5881.441263080001;5893.057110862242;5930.169776231331;6006;6009.248843894513;6195.380461953769;6248.843778905563;6254.718537665816;6268.655223962726;6285.717142728588;5843.912341314884;5923.585349025527;5937.584369094208;5939.970300148471;5968.970155149196;5489.670619762827;5493.505584497335;5515.420880807537;5519.172124181325;5523.8895222096135;6434.485241180788;6435.066915297256;6449.419552240321;6453.806385808433;6465.353464653591;6135.600157732601;6189.876202476015;6229.56393052482;6243.219597550306;6245.750169993149;5416.539594134542;6432.2281326241155;6445.548811583331;6469.061986012096;6502.252240992347;6155.784547540815;6189.381061893775;6205.81382558524;6252.343503932204;6275.184226050585;6113.962834745988;6186.041163619646;6271.62370257786;6275.905861411991;6276.372362763687;6072.90890636632;6155.876882462415;6158.445739883432;6253.312135664983;6271;6228.34602366745;6232.283287422005;6248.343923887926;6248.4376406123665;6248.562600617913;5010.9248361273885;5925.318588362394;5975.804839032124;6070.1198326241565;6163.322034576283;6108.281362586102;6112.47308512798;6159.384061593805;6161.84595385119;6241.469475094668;6125.754969801158;6132.47873930703;6152.630842149306;6153;6180.412860778219 09:38:50 INFO - PROCESS | 1936 | |1;ext.html;475.7335891900536;486.96834705744124;523.5183631059425;530.6975024236184;538.8383484954512;39567.60432395679;41543.58456415435;41569.16861662765;41701.582984170185;41761.3735793963;39135.80432097843;39848.20303593934;42639;42699.57300426995;43288.3506747399;9611.711648650535;9794.461304628243;9804;9820.705378838611;9844.95077524615;9664.855027174597;9753.853692194623;9773.218142548614;9774.609015639366;9806.705798826011;8753.299736021103;8771.429857059302;8948.776280592972;9757.268204884627;9807.607695692164;7805.37556995439;9738.464384458852;9762.072603102693;9765.804683906283;9766.902330976742;9643.90356096437;9682.903170968271;9751.609935602568;9761.951190244074;9783.315167938246;41008.179836403106;41031.384529232084;41069.589304107176;41230.79384603088;41889;3283.277678910636;3364.5457863188644;3393.677600627961;3471.531343268677;3580.15866271426;25051.498970020497;29118;29283.560746588817;31901.52147717763;31966;3075.861586228603;3107.8756849725983;3168.112928380034;3291.2594666200152;3309.1892486341;498658;504872;506610;506795;509756.45121774526;61981.690091550154;62547.061794073124;62756.686216569535;62760.68619656873;62867.056994145125;34338.48492272618;34716.30567388638;35220.47169292463;36162;36321.45517817235;16846.747298790528;17018.14909254532;17037.57406064858;17050.147492625318;17066.829331706773;12990.415431305613;13035.087543872027;13100.082994190505;13107.934460327828;13132.868671313356;16095.758563621555;18873.716894246598;19056.333028343943;19131.13909874059;19228.61542769137;6572.868542629216;7848.568328741974;7880.802979925547;7923.960380198062;8009.199080091944;860.9139086091466;955.0926619711302;1004.7638804880847;1073.5759375046812;1081.6160263106642;25984.220473385827;28780.856095719806;30394.54408183879;30487.542686859713;30893.84553077265;887.2414085956543;1046.9162467002623;1059.1897198643044;1106.8505751723576;1110.5844787586966;13811.861881381259;14006.509772157926;15624.92187539055;15812.288447019911;16109.516714498584;705208;722564;723603;724549;724838;57667.84664306691;57706.55733606609;58309.416905830396;58400.70799645974;58455.12317315244;1116.0123290887623;1146.2434793036389;1257.6352857671172;1266.911316207875;1351.4121357209644;29157.833686652295;29765;29885.252868678457;29897;30162.396752064396;49241.50758492369;49503.75248123737;49567.27379994135;49639.262625807925;49835.750821247115;627879;633081;633238;635129;642343;26118.73881261239;26125.216243512725;26380.340491487867;26621;26622.733772662024;46058.84852878705;46914.76542617402;47213.52786472091;47525.7623711893;48029;39221.803890980365;39330.213395731356;39482.80258598689;39505.81482555528;40284.59715402809;32552.51171232481;38689;38963.610363896;39347.24024353636;40043;37848.81075594604;38381.23237535178;38538.614613854625;38607;39761.40357894692;32220.19449513781;34519.654803451645;35300;35403;35434.29131417305;25618.615720764577;25863.353416164748;25880.611790822775;26168.73831261663;26465 09:38:50 INFO - PROCESS | 1936 | |2;jquery.html;376.41279603818043;378.47581100176245;381.4945197613163;385.0489291450117;400.22356628141404;18513.629727405445;20092.899535502303;21307.25424610137;21453.141874325007;21535.46161345965;19481.415557533295;19545.609087818237;20134.89932550339;20185.798142018575;20476.18095276187;5377.193420986844;5432.70120143391;5566.610337276392;5630.268065151525;5669.319681638209;3894.6884249259992;5495;5506.476884695948;5545.556355491551;5552.611317207797;4111.917761644765;5880.764769409218;6113.23584551931;6157.846053848667;6208.565400421972;5999.790007349744;6130;6186.783462578788;6206.224221972254;6245.500359971192;5984.581079324449;6025.548083893682;6025.728842202111;6035.094735789623;6044.576879618428;12732.87267127326;13045.86954130456;13059.020573456934;13117.803232951514;13205.943524518112;2231.0964059555745;2279.7606251343536;2397.6883005209384;2764.9447011059665;2829.1936798012675;9395.62417503299;9811.411315321104;14016.92991535046;14475.565733028026;15378.692426151414;1839.6044850357237;1890.6596812573732;1925.5571218619655;1943.543267332176;1949.9415017549495;97015.0298497013;115376;118284.22573661403;119837;127672;9698.806023879482;11214.551417943354;11247.66257012291;11558.768824623628;11905.761884762256;11567.710807229887;12116.878831211576;13745.793813092812;14150.221737804313;14600.41598336076;7028.332308430691;8442.15578442151;8566;8680.435771674947;8681.262092722189;8573.813677512318;8608.375051070347;8623.31013518917;8775.561221938877;8859.11408859109;4321.567843215653;4441.200583894865;4523.954760452353;4536.002079542495;4625.259958406638;1597.1295643874116;1894.3275137326327;1948.6492431362492;1956.0708663385062;1968.8917109558824;844.7423535821633;857.652650676477;900.7029876977132;923.7644400677918;1020;16533.83466165347;20159.39521814348;20420.0810963507;20739.688904666444;21307;891.9108089191029;923.704414587339;927.9931274567035;939.4504215034282;962.6871266838306;8924.821503569892;10422.062014418738;10860.837087443695;10903.182261330274;11114;619147;621044;631003;631675;632659;132578;133518;135172.648273516;139812;141165;928.7167413938679;938.863864739609;959.6065613098735;960.5917485068818;963.4652767713986;16521.84347095692;16909;18562.628747425246;18615.813841861407;18884.716729249347;56908.34609838533;57498.7125064372;58030.419695804194;58730;60283.49291267753;79520;79877.8018329714;83066.33867322741;83517.16482835094;85558.57220713857;6758.797236082925;6759.357861003394;6972.4073453757;7165.570065796069;7215.494915355875;10568.418736969541;12580.748385032066;12588.937055314665;12615;12811.487540498649;8646.870296945424;10828.24202305831;10861.945690271814;11029.669109926715;11061.612843550438;10769.24615276923;11067;11134.498947547218;11175.832362514406;11206;10226.23303252274;10227.7443063924;11069.778604428027;11430;11523.769524609294;7931.365490760841;7974.202579742211;8269.627866746132;8302.460340077876;8326.916730832614;10126.291159618757;10889.673309800719;11115.22193446451;11268.718282043015;11514.19400641947 09:38:50 INFO - PROCESS | 1936 | |3;mootools.html;1468.7356275870343;1513.409770189626;1693.018049531272;1811.501836994827;1825.1513046433406;7814.609269536515;8083.43415960883;8566.957165214173;9134.132257435542;9163.816723665532;8538.658453661861;8855.158759917798;8861.601227944742;8967.148120928518;8983.416077954927;1849.7965223825436;2027.6248893954591;2309.9422514437106;2363.1020212319336;2412.577798885197;2386.284114765572;2413.070967677439;2424.6726691896633;2441.3520873410466;2445.2297526279253;2040.8061234182728;2067.24545540878;2416.6012607919674;2426.33275849142;2434.586120359534;2032.2886989553613;2048.068129001301;2198.3844523533435;2276.7364112917408;2406.554787364343;2399.9880000599887;2406.8796560172095;2412.541617092764;2412.9865456508132;2420.636904464327;8948.597313120925;8983.056779038172;9055.547222638908;9078.591463384164;9112.772180695536;5306.946930530722;5391.137418013099;5436.157395603688;5456.399796022434;5460.989716902386;2859.342351259222;3613.4747639585175;3634.0733113056003;3720.21875406165;3747.306748251582;1114.6934592986993;1115.576081089189;1807.2951548895942;1858.7397764313007;1903.172120127749;11527;11623.244489108265;11672.941635291769;11769.470373833197;11804.291742495478;4007.8196481158416;4490.3040028795585;4505.211587972091;4642.3500709900645;4669.182892993713;9049.683261085831;9094.499802510925;9127.224185944136;9155.54222288883;9167.404118732262;5277.23480095384;5288.8413347599635;5292.867678308073;5307.124324486494;5325.121354976385;4400;4572.3827283317;4924.556789888928;4957.6281778866005;4980.501949805063;3230.3862266169353;3504.6144924058335;3791.3554695701796;3865.0867820429066;3880.243352546283;982.5382070426888;1079.63292480557;1084.2301965604352;1092.0990183098975;1094.026316578246;751.9436042296741;869.6956065377068;906.4244204929917;915.4507295622573;921.5944984206927;5059.519345662156;5717.714114294268;5818.4763371296785;5870.3249126350165;6017.548683848729;891.7754076545747;969.2827307792325;970.6990832841842;974.2303580171586;985.5515740338129;3839.7504162229366;3998.9200215996098;4021.1756589899;4037.2329257440992;4116.608922152391;10623.946880265548;10867.130629549618;11032.227744058;11045.83431248532;11062.280951738112;10861.456927153611;10906.563737450413;10910.23628346008;10928.781424371628;10936.179786516042;7891.723789667334;8153.918460815435;8274.958625206835;8291.378146639026;8369.079401265977;5809.215755873072;5917.289925209003;5936.495397891227;5995.520358371407;6005.579609427298;10074.647387341702;10211.540480678239;10300.845487317845;10311.587536498757;10319.071283584513;10014.39913605186;10119.949400253246;10300.690979270634;10379.481025948824;10472.633457828939;6559.376859198369;6880.415164711056;7123.82190445243;7142.178649455379;7573.242675732603;7971;8125.878111828446;8156.306713929383;8173.34613230952;8180.550069746221;7191.137063552407;7382.44631652639;7386.2244464332625;7399.704011839466;7483.289087536676;7210.603416812126;7213.855722885618;7232.602206878672;7261.128664560287;7362.7423040193335;5421;6251.9687401562705;6415.166028416463;6850.21222559412;6899.482538809509;4887.682300650446;4898;4936.629752768485;4954.355933728736;4961.776720047678;4854.490278520846;4912.238603016538;4958.57852082577;5009.073321435546;5045.293658887832 09:38:50 INFO - PROCESS | 1936 | |4;prototype.html;297.0997876434403;301.68021896789406;308.5110100490722;308.6959345045129;308.8687307894145;5245.6852588844695;5270.683758974455;5326.866828329294;5434.91847622286;5490.450954904508;4895.5838753705975;5061.266116413118;5077.365329333833;5135.075686376451;5197.232940800127;3438.70770984466;4149.419081328617;4156.937645935313;4161.625453709165;4186.372044193365;3879.398693202558;4094.34490481523;4165.791710414483;4171.436856024443;4195.5175154857125;3588.9641103588892;4059.1733719826047;4066.430699702044;4089.5092588889224;4107.158032603309;3422.9486557701653;3446.724262059042;4060.7969601519953;4065.3495440729343;4128.504579450485;3522.3131489359585;3528.7353448491467;3541.8052007139595;3543.8405271762576;3558;4983.9252411213865;5330.466953304677;5345.599080069011;5351.973240133813;5362.410134885159;4093.853720958107;4685.062987402499;4724.669273150881;4730.172219861545;4750.952490475085;4992.853073178532;5093.592512599021;5632.493075623172;5746.080627099644;5817.447342502455;3702.4631428442995;3752.2683076800035;3768.679662228714;3844.942325865114;3911.3741801311653;4560.042391097873;4786.545278198566;4891.364122664067;5533.612647114664;5602.803901863415;3586.300671369058;3885.6502914737807;3894.3184942634925;3909.3745000799736;3923.4507168996365;3339.5157702133056;3704.111013356775;3934.3508321127265;3952.466417033721;3981.6217459341315;4448.911021779546;4659.301104834234;4663.347131401607;4664.836730714409;4727.479977202505;4924.975375123101;5189.636725429259;5825.912611310834;5886.1752856614585;5887.911681324784;1261.369315342329;1300.9787316956144;1319.3771660857008;1345.327336331834;1347.8854297384637;768.1435199752236;818.5743413424985;876.4303202918027;904.8371293167162;914.4421902639384;5020.472850350734;5387.730613469311;5388.380336261302;5394.62237643369;5421.891562168735;5443.700596467233;5451.092117758832;5862.267216597926;5875.588708790429;5884.617499862496;4235.449391579075;4902.779374928136;5034.949650503521;5292.470752924677;5337.8131765388025;2496.3883848457244;2566.84385116503;2584.483103379294;2615.6207349934534;2615.9869200653875;4409.302418568874;4592.632589392841;5044.419891712427;5104.310918026019;5205.24523944026;4571.9085618287445;4778.856634300976;4928.926066109011;5128.820491282787;5456;5154.587632989352;6264.342244064399;6268.49852011838;6293.937060629335;6304.527160463075;5188.066148093229;6026.668533230714;6050.42520960508;6077.604955677867;6121.112438696453;5332.760025798771;5870.031444811559;5884.529237661062;5919.792807251725;5940.8811823764145;6216.595921265103;6242.469390101892;6275.592086514362;6301.747930082745;6333.240011198685;3630.7640003399692;3825.980870095632;3874.6900247980657;3912.5304963404574;3928.6857051435245;5643.35101463337;5678.5457163426;5975.37258587842;5984.294476074298;6012.1582978382185;5127.154634024481;5313.309269794902;5536.003519366392;5856;5869.911951320819;5047.470015648304;5475.780968761205;5782.710864456676;5834.241548598655;5883.823485295448;5278.788848446019;5600.747966341443;5686.857828554319;5693.430656934273;5708.343540492897;5247.422783493889;5510.228568000563;5825.446582574648;5841.174031009696;5878.647281163144;4765.7140571565815;5679;5709.885802284014;5750.367459579359;5780.161876527964 09:38:50 INFO - PROCESS | 1936 | |5;yui.html;617.3055312773131;714.8463080437705;773.7678696391081;774.8725604245823;820.8850760893476;13793.51722689706;13872.722545549082;14928.701425971474;15390.692186156284;15454.1500217488;12281.44733486993;14134;14395.424183032666;14403.78394324086;14461.927690361534;672.4687496877485;693.0574418790441;813.9959300203506;838.5388036579888;844.8943882014748;832.309183377798;854.133054949227;863.3913091270639;864.1229152410309;865.3380164174412;886.2821114896922;894.2488309819751;894.3292530602048;894.5616647842543;895.5566994337779;884.3146561414891;884.5179377239356;885.6014793342989;888;888.942218755782;631.050269344638;632.294991084937;654.5156584127759;658.1148355461896;660.1220376898713;11427.771444571144;12402.689932751664;13527.917766578748;14451;14809;14138.85861141396;14280.000399972007;14312.856871431257;14400.855991440056;14627.488037918729;10404.843927341097;11314.490847911782;11316.377599232039;11625.534978600846;11777;3116.750659947199;3798.4682144499793;3856.5372155341256;3949.3878448840474;3951.881443556698;112972.26577714738;117608;117919.41040294744;118426.40786796097;118746;10608.15134789215;10784.460776961278;10927.453627318602;11061.059809916087;11408.429578521042;21997.010134543663;22220.444488887908;22222.555548888933;22309.442263943532;22449;7946.205379462008;7966.6415011324625;8014.71948481812;8068.47554908929;8167.0199576051255;4424.33634954753;4465.24090904547;4553.954460455419;4593.333966574828;4668.393108895822;3539.94690079649;3616.1321282891918;3642.85428582859;3657.65252301031;3671.8714844980295;642.858571114354;657.7040331850591;660.7092879133262;663.2637772072995;667.5794249622707;578.7974209026892;588.109014842514;602.3494625804121;622.7602373086304;646.7994921574327;9335.393199442015;9339.626414943463;9408.388454750557;9682.080202380763;9841.655542055994;632.7089538812106;650.8210242183343;668.6422763821332;670.4904272752743;675.1998881325645;4571;4725.29120631908;4725.621950243973;4770.689905156154;4779.163646361872;146155;172203.27796721872;172725;174424;175456;111109;132677.33661331824;135317.3234133823;135800.32099839437;145406.5459345414;80769;82545;119620.40189798996;124491.37754311171;130853.69146308606;8703.43427677199;8924.955375223342;9071.183593476619;9125.634974600942;9223.21602663781;55461.445385547246;68450.3154968464;68841;69350.65324673345;71147;98312;108357;111201;113141.43429282801;113890;11553.884461155618;11791.469383877575;11824.467898944396;11994.220375675553;12216.87783122193;12198.878011219775;12313.56902508408;12841.614751557468;12864.356782160667;12907.548235811702;12498;13504.93247533756;13535.458581656623;13609.659758506117;14005.299735013412;12944.032648035572;12957.02822288351;13396.531121410704;13745.450181992608;14281;11036.668899933014;12343.889049985186;12849.486020559072;13026.47894084226;13874.774994889016;10925.672229833117;11434.428278586203;11529.711757205801;11634.76730465403;11867.703307417038;8966.282697384064;10402.47987600632;10407.895921040996;11535.711607209887;11824.46789894474 09:38:50 INFO - PROCESS | 1936 | __end_tp_report 09:38:50 INFO - PROCESS | 1936 | __start_cc_report 09:38:50 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,364 09:38:50 INFO - PROCESS | 1936 | __end_cc_report 09:38:50 INFO - PROCESS | 1936 | __startTimestamp1476290330424__endTimestamp 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | ------- Summary: start ------- 09:38:50 INFO - PROCESS | 1936 | Number of tests: 6 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#0] dojo.html Cycles:165 Average:5780.78 Median:5991.79 stddev:636.87 (10.6%) stddev-sans-first:610.81 09:38:50 INFO - PROCESS | 1936 | Values: 3399.2 3404.3 3446.5 3451.6 3455.2 5825.3 5846.2 5875.1 5885.2 5894.1 5855.1 5903.6 5923.2 5956.1 6002.7 5316.5 5384.1 5402.5 5415.0 5473.9 5397.6 5422.0 5423.6 5439.0 5442.6 5299.5 5307.2 5422.2 5423.3 5440.3 5295.9 5353.7 5357.1 5363.2 5416.2 5217.5 5309.8 5311.9 5331.9 5338.9 4984.0 5880.7 5899.5 5981.4 5991.8 6088.7 6111.0 6159.9 6188.0 6251.2 4801.8 5785.0 6017.4 6285.1 6287.4 4486.0 5154.9 5840.2 5971.1 5971.8 6189.7 6252.2 6260.7 6306.0 6311.4 5150.8 5800.9 6190.7 6247.7 6273.0 5706.3 6195.3 6265.4 6271.7 6283.7 5150.3 6128.3 6147.8 6174.2 6205.5 5686.8 6206.0 6218.2 6234.8 6237.1 5017.9 5021.6 5030.1 5041.7 5053.3 4432.4 4440.6 4444.8 4505.5 4510.6 5881.4 5893.1 5930.2 6006.0 6009.2 6195.4 6248.8 6254.7 6268.7 6285.7 5843.9 5923.6 5937.6 5940.0 5969.0 5489.7 5493.5 5515.4 5519.2 5523.9 6434.5 6435.1 6449.4 6453.8 6465.4 6135.6 6189.9 6229.6 6243.2 6245.8 5416.5 6432.2 6445.5 6469.1 6502.3 6155.8 6189.4 6205.8 6252.3 6275.2 6114.0 6186.0 6271.6 6275.9 6276.4 6072.9 6155.9 6158.4 6253.3 6271.0 6228.3 6232.3 6248.3 6248.4 6248.6 5010.9 5925.3 5975.8 6070.1 6163.3 6108.3 6112.5 6159.4 6161.8 6241.5 6125.8 6132.5 6152.6 6153.0 6180.4 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#1] ext.html Cycles:180 Average:73824.02 Median:39664.50 stddev:167955.13 (423.4%) stddev-sans-first:168336.00 09:38:50 INFO - PROCESS | 1936 | Values: 475.7 487.0 523.5 530.7 538.8 39567.6 41543.6 41569.2 41701.6 41761.4 39135.8 39848.2 42639.0 42699.6 43288.4 9611.7 9794.5 9804.0 9820.7 9845.0 9664.9 9753.9 9773.2 9774.6 9806.7 8753.3 8771.4 8948.8 9757.3 9807.6 7805.4 9738.5 9762.1 9765.8 9766.9 9643.9 9682.9 9751.6 9762.0 9783.3 41008.2 41031.4 41069.6 41230.8 41889.0 3283.3 3364.5 3393.7 3471.5 3580.2 25051.5 29118.0 29283.6 31901.5 31966.0 3075.9 3107.9 3168.1 3291.3 3309.2 498658.0 504872.0 506610.0 506795.0 509756.5 61981.7 62547.1 62756.7 62760.7 62867.1 34338.5 34716.3 35220.5 36162.0 36321.5 16846.7 17018.1 17037.6 17050.1 17066.8 12990.4 13035.1 13100.1 13107.9 13132.9 16095.8 18873.7 19056.3 19131.1 19228.6 6572.9 7848.6 7880.8 7924.0 8009.2 860.9 955.1 1004.8 1073.6 1081.6 25984.2 28780.9 30394.5 30487.5 30893.8 887.2 1046.9 1059.2 1106.9 1110.6 13811.9 14006.5 15624.9 15812.3 16109.5 705208.0 722564.0 723603.0 724549.0 724838.0 57667.8 57706.6 58309.4 58400.7 58455.1 1116.0 1146.2 1257.6 1266.9 1351.4 29157.8 29765.0 29885.3 29897.0 30162.4 49241.5 49503.8 49567.3 49639.3 49835.8 627879.0 633081.0 633238.0 635129.0 642343.0 26118.7 26125.2 26380.3 26621.0 26622.7 46058.8 46914.8 47213.5 47525.8 48029.0 39221.8 39330.2 39482.8 39505.8 40284.6 32552.5 38689.0 38963.6 39347.2 40043.0 37848.8 38381.2 38538.6 38607.0 39761.4 32220.2 34519.7 35300.0 35403.0 35434.3 25618.6 25863.4 25880.6 26168.7 26465.0 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#2] jquery.html Cycles:180 Average:35801.16 Median:377.44 stddev:104748.86 (27752.1%) stddev-sans-first:105008.94 09:38:50 INFO - PROCESS | 1936 | Values: 376.4 378.5 381.5 385.0 400.2 18513.6 20092.9 21307.3 21453.1 21535.5 19481.4 19545.6 20134.9 20185.8 20476.2 5377.2 5432.7 5566.6 5630.3 5669.3 3894.7 5495.0 5506.5 5545.6 5552.6 4111.9 5880.8 6113.2 6157.8 6208.6 5999.8 6130.0 6186.8 6206.2 6245.5 5984.6 6025.5 6025.7 6035.1 6044.6 12732.9 13045.9 13059.0 13117.8 13205.9 2231.1 2279.8 2397.7 2764.9 2829.2 9395.6 9811.4 14016.9 14475.6 15378.7 1839.6 1890.7 1925.6 1943.5 1949.9 97015.0 115376.0 118284.2 119837.0 127672.0 9698.8 11214.6 11247.7 11558.8 11905.8 11567.7 12116.9 13745.8 14150.2 14600.4 7028.3 8442.2 8566.0 8680.4 8681.3 8573.8 8608.4 8623.3 8775.6 8859.1 4321.6 4441.2 4524.0 4536.0 4625.3 1597.1 1894.3 1948.6 1956.1 1968.9 844.7 857.7 900.7 923.8 1020.0 16533.8 20159.4 20420.1 20739.7 21307.0 891.9 923.7 928.0 939.5 962.7 8924.8 10422.1 10860.8 10903.2 11114.0 619147.0 621044.0 631003.0 631675.0 632659.0 132578.0 133518.0 135172.6 139812.0 141165.0 928.7 938.9 959.6 960.6 963.5 16521.8 16909.0 18562.6 18615.8 18884.7 56908.3 57498.7 58030.4 58730.0 60283.5 79520.0 79877.8 83066.3 83517.2 85558.6 6758.8 6759.4 6972.4 7165.6 7215.5 10568.4 12580.7 12588.9 12615.0 12811.5 8646.9 10828.2 10861.9 11029.7 11061.6 10769.2 11067.0 11134.5 11175.8 11206.0 10226.2 10227.7 11069.8 11430.0 11523.8 7931.4 7974.2 8269.6 8302.5 8326.9 10126.3 10889.7 11115.2 11268.7 11514.2 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#3] mootools.html Cycles:180 Average:5671.33 Median:4930.59 stddev:3205.20 (65.0%) stddev-sans-first:3198.63 09:38:50 INFO - PROCESS | 1936 | Values: 1468.7 1513.4 1693.0 1811.5 1825.2 7814.6 8083.4 8567.0 9134.1 9163.8 8538.7 8855.2 8861.6 8967.1 8983.4 1849.8 2027.6 2309.9 2363.1 2412.6 2386.3 2413.1 2424.7 2441.4 2445.2 2040.8 2067.2 2416.6 2426.3 2434.6 2032.3 2048.1 2198.4 2276.7 2406.6 2400.0 2406.9 2412.5 2413.0 2420.6 8948.6 8983.1 9055.5 9078.6 9112.8 5306.9 5391.1 5436.2 5456.4 5461.0 2859.3 3613.5 3634.1 3720.2 3747.3 1114.7 1115.6 1807.3 1858.7 1903.2 11527.0 11623.2 11672.9 11769.5 11804.3 4007.8 4490.3 4505.2 4642.4 4669.2 9049.7 9094.5 9127.2 9155.5 9167.4 5277.2 5288.8 5292.9 5307.1 5325.1 4400.0 4572.4 4924.6 4957.6 4980.5 3230.4 3504.6 3791.4 3865.1 3880.2 982.5 1079.6 1084.2 1092.1 1094.0 751.9 869.7 906.4 915.5 921.6 5059.5 5717.7 5818.5 5870.3 6017.5 891.8 969.3 970.7 974.2 985.6 3839.8 3998.9 4021.2 4037.2 4116.6 10623.9 10867.1 11032.2 11045.8 11062.3 10861.5 10906.6 10910.2 10928.8 10936.2 7891.7 8153.9 8275.0 8291.4 8369.1 5809.2 5917.3 5936.5 5995.5 6005.6 10074.6 10211.5 10300.8 10311.6 10319.1 10014.4 10119.9 10300.7 10379.5 10472.6 6559.4 6880.4 7123.8 7142.2 7573.2 7971.0 8125.9 8156.3 8173.3 8180.6 7191.1 7382.4 7386.2 7399.7 7483.3 7210.6 7213.9 7232.6 7261.1 7362.7 5421.0 6252.0 6415.2 6850.2 6899.5 4887.7 4898.0 4936.6 4954.4 4961.8 4854.5 4912.2 4958.6 5009.1 5045.3 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#4] prototype.html Cycles:180 Average:4567.12 Median:5085.48 stddev:1440.58 (28.3%) stddev-sans-first:1408.52 09:38:50 INFO - PROCESS | 1936 | Values: 297.1 301.7 308.5 308.7 308.9 5245.7 5270.7 5326.9 5434.9 5490.5 4895.6 5061.3 5077.4 5135.1 5197.2 3438.7 4149.4 4156.9 4161.6 4186.4 3879.4 4094.3 4165.8 4171.4 4195.5 3589.0 4059.2 4066.4 4089.5 4107.2 3422.9 3446.7 4060.8 4065.3 4128.5 3522.3 3528.7 3541.8 3543.8 3558.0 4983.9 5330.5 5345.6 5352.0 5362.4 4093.9 4685.1 4724.7 4730.2 4751.0 4992.9 5093.6 5632.5 5746.1 5817.4 3702.5 3752.3 3768.7 3844.9 3911.4 4560.0 4786.5 4891.4 5533.6 5602.8 3586.3 3885.7 3894.3 3909.4 3923.5 3339.5 3704.1 3934.4 3952.5 3981.6 4448.9 4659.3 4663.3 4664.8 4727.5 4925.0 5189.6 5825.9 5886.2 5887.9 1261.4 1301.0 1319.4 1345.3 1347.9 768.1 818.6 876.4 904.8 914.4 5020.5 5387.7 5388.4 5394.6 5421.9 5443.7 5451.1 5862.3 5875.6 5884.6 4235.4 4902.8 5034.9 5292.5 5337.8 2496.4 2566.8 2584.5 2615.6 2616.0 4409.3 4592.6 5044.4 5104.3 5205.2 4571.9 4778.9 4928.9 5128.8 5456.0 5154.6 6264.3 6268.5 6293.9 6304.5 5188.1 6026.7 6050.4 6077.6 6121.1 5332.8 5870.0 5884.5 5919.8 5940.9 6216.6 6242.5 6275.6 6301.7 6333.2 3630.8 3826.0 3874.7 3912.5 3928.7 5643.4 5678.5 5975.4 5984.3 6012.2 5127.2 5313.3 5536.0 5856.0 5869.9 5047.5 5475.8 5782.7 5834.2 5883.8 5278.8 5600.7 5686.9 5693.4 5708.3 5247.4 5510.2 5825.4 5841.2 5878.6 4765.7 5679.0 5709.9 5750.4 5780.2 09:38:50 INFO - PROCESS | 1936 | 09:38:50 INFO - PROCESS | 1936 | [#5] yui.html Cycles:180 Average:26041.36 Median:12782.88 stddev:43147.02 (337.5%) stddev-sans-first:43225.83 09:38:50 INFO - PROCESS | 1936 | Values: 617.3 714.8 773.8 774.9 820.9 13793.5 13872.7 14928.7 15390.7 15454.2 12281.4 14134.0 14395.4 14403.8 14461.9 672.5 693.1 814.0 838.5 844.9 832.3 854.1 863.4 864.1 865.3 886.3 894.2 894.3 894.6 895.6 884.3 884.5 885.6 888.0 888.9 631.1 632.3 654.5 658.1 660.1 11427.8 12402.7 13527.9 14451.0 14809.0 14138.9 14280.0 14312.9 14400.9 14627.5 10404.8 11314.5 11316.4 11625.5 11777.0 3116.8 3798.5 3856.5 3949.4 3951.9 112972.3 117608.0 117919.4 118426.4 118746.0 10608.2 10784.5 10927.5 11061.1 11408.4 21997.0 22220.4 22222.6 22309.4 22449.0 7946.2 7966.6 8014.7 8068.5 8167.0 4424.3 4465.2 4554.0 4593.3 4668.4 3539.9 3616.1 3642.9 3657.7 3671.9 642.9 657.7 660.7 663.3 667.6 578.8 588.1 602.3 622.8 646.8 9335.4 9339.6 9408.4 9682.1 9841.7 632.7 650.8 668.6 670.5 675.2 4571.0 4725.3 4725.6 4770.7 4779.2 146155.0 172203.3 172725.0 174424.0 175456.0 111109.0 132677.3 135317.3 135800.3 145406.5 80769.0 82545.0 119620.4 124491.4 130853.7 8703.4 8925.0 9071.2 9125.6 9223.2 55461.4 68450.3 68841.0 69350.7 71147.0 98312.0 108357.0 111201.0 113141.4 113890.0 11553.9 11791.5 11824.5 11994.2 12216.9 12198.9 12313.6 12841.6 12864.4 12907.5 12498.0 13504.9 13535.5 13609.7 14005.3 12944.0 12957.0 13396.5 13745.5 14281.0 11036.7 12343.9 12849.5 13026.5 13874.8 10925.7 11434.4 11529.7 11634.8 11867.7 8966.3 10402.5 10407.9 11535.7 11824.5 09:38:50 INFO - PROCESS | 1936 | -------- Summary: end -------- 09:38:50 INFO - PROCESS | 1936 | 09:38:51 INFO - TEST-INFO | 1936: exit 0 09:38:51 INFO - TEST-OK | dromaeo_css | took 1113037ms 09:38:51 INFO - TEST-START | kraken 09:38:51 INFO - operating with platform_type : mac_ 09:38:51 INFO - Initialising browser for kraken test... 09:38:51 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp62hkS4/profile http://localhost:53104/getInfo.html) 09:38:53 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 09:38:53 INFO - PROCESS | 1943 | colorDepth:24 09:38:53 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 09:38:53 INFO - PROCESS | 1943 | __metrics 09:38:53 ERROR - PROCESS | 1943 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:38:54 INFO - TEST-INFO | 1943: exit 0 09:38:54 INFO - Browser initialized. 09:38:54 INFO - Running cycle 1/1 for kraken test... 09:38:54 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp62hkS4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:06 INFO - PROCESS | 1945 | RSS: Main: 224923648 09:39:06 INFO - PROCESS | 1945 | 09:39:09 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53104/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:10 INFO - PROCESS | 1945 | RSS: Main: 237563904 09:39:10 INFO - PROCESS | 1945 | 09:39:13 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53104/tests/kraken/driver.html?testName=audio-dft) 09:39:13 INFO - PROCESS | 1945 | RSS: Main: 245944320 09:39:13 INFO - PROCESS | 1945 | 09:39:16 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53104/tests/kraken/driver.html?testName=audio-fft) 09:39:17 INFO - PROCESS | 1945 | RSS: Main: 249208832 09:39:17 INFO - PROCESS | 1945 | 09:39:19 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53104/tests/kraken/driver.html?testName=audio-oscillator) 09:39:20 INFO - PROCESS | 1945 | RSS: Main: 250662912 09:39:20 INFO - PROCESS | 1945 | 09:39:21 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:22 INFO - PROCESS | 1945 | RSS: Main: 250613760 09:39:22 INFO - PROCESS | 1945 | 09:39:25 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53104/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:26 INFO - PROCESS | 1945 | RSS: Main: 251387904 09:39:26 INFO - PROCESS | 1945 | 09:39:29 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53104/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:30 INFO - PROCESS | 1945 | RSS: Main: 251383808 09:39:30 INFO - PROCESS | 1945 | 09:39:33 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53104/tests/kraken/driver.html?testName=json-parse-financial) 09:39:33 INFO - PROCESS | 1945 | RSS: Main: 251867136 09:39:33 INFO - PROCESS | 1945 | 09:39:35 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:35 INFO - PROCESS | 1945 | RSS: Main: 251265024 09:39:35 INFO - PROCESS | 1945 | 09:39:37 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:38 INFO - PROCESS | 1945 | RSS: Main: 251322368 09:39:38 INFO - PROCESS | 1945 | 09:39:40 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:41 INFO - PROCESS | 1945 | RSS: Main: 251269120 09:39:41 INFO - PROCESS | 1945 | 09:39:44 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:44 INFO - PROCESS | 1945 | RSS: Main: 251322368 09:39:44 INFO - PROCESS | 1945 | 09:39:47 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:48 INFO - PROCESS | 1945 | RSS: Main: 251666432 09:39:48 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53104/tests/kraken/driver.html?testName=ai-astar) 09:39:50 INFO - PROCESS | 1945 | RSS: Main: 253435904 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | __start_tp_report 09:39:50 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 09:39:50 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 09:39:50 INFO - PROCESS | 1945 | |i|pagename|runs| 09:39:50 INFO - PROCESS | 1945 | |0;ai-astar;106;116;119;117;120;117;117;120;141;120 09:39:50 INFO - PROCESS | 1945 | |1;audio-beat-detection;144;111;112;133;138;148;140;125;142;110 09:39:50 INFO - PROCESS | 1945 | |2;audio-dft;197;200;203;197;198;194;195;198;197;194 09:39:50 INFO - PROCESS | 1945 | |3;audio-fft;80;57;57;84;60;58;59;59;83;52 09:39:50 INFO - PROCESS | 1945 | |4;audio-oscillator;92;69;89;73;72;70;90;69;70;87 09:39:50 INFO - PROCESS | 1945 | |5;imaging-gaussian-blur;107;112;89;86;89;96;132;87;89;85 09:39:50 INFO - PROCESS | 1945 | |6;imaging-darkroom;127;116;171;164;98;99;100;129;168;152 09:39:50 INFO - PROCESS | 1945 | |7;imaging-desaturate;92;96;90;120;118;89;91;93;142;148 09:39:50 INFO - PROCESS | 1945 | |8;json-parse-financial;54;55;54;57;59;59;57;65;82;86 09:39:50 INFO - PROCESS | 1945 | |9;json-stringify-tinderbox;66;83;84;74;70;68;70;70;74;73 09:39:50 INFO - PROCESS | 1945 | |10;stanford-crypto-aes;85;85;84;84;81;85;84;83;88;88 09:39:50 INFO - PROCESS | 1945 | |11;stanford-crypto-ccm;150;158;148;147;155;147;140;139;170;157 09:39:50 INFO - PROCESS | 1945 | |12;stanford-crypto-pbkdf2;165;162;162;166;165;165;168;173;161;179 09:39:50 INFO - PROCESS | 1945 | |13;stanford-crypto-sha256-iterative;69;79;70;77;88;85;80;67;64;67 09:39:50 INFO - PROCESS | 1945 | __end_tp_report 09:39:50 INFO - PROCESS | 1945 | __start_cc_report 09:39:50 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,938 09:39:50 INFO - PROCESS | 1945 | __end_cc_report 09:39:50 INFO - PROCESS | 1945 | __startTimestamp1476290390281__endTimestamp 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | ------- Summary: start ------- 09:39:50 INFO - PROCESS | 1945 | Number of tests: 14 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#0] ai-astar Cycles:10 Average:119.30 Median:119.50 stddev:8.67 (7.3%) stddev-sans-first:7.74 09:39:50 INFO - PROCESS | 1945 | Values: 106.0 116.0 119.0 117.0 120.0 117.0 117.0 120.0 141.0 120.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:139.00 stddev:14.70 (10.6%) stddev-sans-first:14.74 09:39:50 INFO - PROCESS | 1945 | Values: 144.0 111.0 112.0 133.0 138.0 148.0 140.0 125.0 142.0 110.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#2] audio-dft Cycles:10 Average:197.30 Median:197.50 stddev:2.75 (1.4%) stddev-sans-first:2.92 09:39:50 INFO - PROCESS | 1945 | Values: 197.0 200.0 203.0 197.0 198.0 194.0 195.0 198.0 197.0 194.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#3] audio-fft Cycles:10 Average:64.90 Median:59.50 stddev:12.26 (20.6%) stddev-sans-first:11.72 09:39:50 INFO - PROCESS | 1945 | Values: 80.0 57.0 57.0 84.0 60.0 58.0 59.0 59.0 83.0 52.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.00 stddev:9.96 (12.5%) stddev-sans-first:9.21 09:39:50 INFO - PROCESS | 1945 | Values: 92.0 69.0 89.0 73.0 72.0 70.0 90.0 69.0 70.0 87.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:88.00 stddev:15.30 (17.4%) stddev-sans-first:15.81 09:39:50 INFO - PROCESS | 1945 | Values: 107.0 112.0 89.0 86.0 89.0 96.0 132.0 87.0 89.0 85.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#6] imaging-darkroom Cycles:10 Average:132.40 Median:166.00 stddev:29.44 (17.7%) stddev-sans-first:31.16 09:39:50 INFO - PROCESS | 1945 | Values: 127.0 116.0 171.0 164.0 98.0 99.0 100.0 129.0 168.0 152.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#7] imaging-desaturate Cycles:10 Average:107.90 Median:90.50 stddev:22.61 (25.0%) stddev-sans-first:23.23 09:39:50 INFO - PROCESS | 1945 | Values: 92.0 96.0 90.0 120.0 118.0 89.0 91.0 93.0 142.0 148.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:59.00 stddev:11.66 (19.8%) stddev-sans-first:11.92 09:39:50 INFO - PROCESS | 1945 | Values: 54.0 55.0 54.0 57.0 59.0 59.0 57.0 65.0 82.0 86.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.50 stddev:6.00 (8.2%) stddev-sans-first:5.77 09:39:50 INFO - PROCESS | 1945 | Values: 66.0 83.0 84.0 74.0 70.0 68.0 70.0 70.0 74.0 73.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:2.11 (2.5%) stddev-sans-first:2.24 09:39:50 INFO - PROCESS | 1945 | Values: 85.0 85.0 84.0 84.0 81.0 85.0 84.0 83.0 88.0 88.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:152.50 stddev:9.24 (6.1%) stddev-sans-first:9.80 09:39:50 INFO - PROCESS | 1945 | Values: 150.0 158.0 148.0 147.0 155.0 147.0 140.0 139.0 170.0 157.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:165.50 stddev:5.56 (3.4%) stddev-sans-first:5.87 09:39:50 INFO - PROCESS | 1945 | Values: 165.0 162.0 162.0 166.0 165.0 165.0 168.0 173.0 161.0 179.0 09:39:50 INFO - PROCESS | 1945 | 09:39:50 INFO - PROCESS | 1945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:78.00 stddev:8.32 (10.7%) stddev-sans-first:8.57 09:39:50 INFO - PROCESS | 1945 | Values: 69.0 79.0 70.0 77.0 88.0 85.0 80.0 67.0 64.0 67.0 09:39:50 INFO - PROCESS | 1945 | -------- Summary: end -------- 09:39:50 INFO - PROCESS | 1945 | 09:39:51 INFO - TEST-INFO | 1945: exit 0 09:39:51 INFO - TEST-OK | kraken | took 60000ms 09:39:51 INFO - SUITE-END | took 1173s 09:39:51 INFO - Completed test suite (00:19:33) 09:39:51 INFO - javascript benchmark 09:39:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7330.832746687851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.1841957930105, 3404.3021180657965, 3446.465797801341, 3451.5512983312165, 3455.1707590178366, 5825.300963884334, 5846.181534585156, 5875.118732190173, 5885.234919460475, 5894.145348924409, 5855.063189889618, 5903.586748927577, 5923.229980102591, 5956.076808094752, 6002.6998650067435, 5316.548093412064, 5384.0847056000575, 5402.513773760361, 5415.025295446818, 5473.932583146288, 5397.62216644835, 5422.0, 5423.620346575742, 5438.972805135989, 5442.564594832404, 5299.5230429261355, 5307.203919412081, 5422.213779002062, 5423.3491980962335, 5440.319960004999, 5295.894082118355, 5353.652012619187, 5357.08929481989, 5363.222332761728, 5416.241726158341, 5217.47825217479, 5309.814156504543, 5311.9468805311835, 5331.920021199685, 5338.893222135574, 4984.0281145176705, 5880.705964701748, 5899.46904778572, 5981.371955944606, 5991.790287339966, 6088.726007329681, 6111.014442317695, 6159.938400615982, 6188.009918413078, 6251.249850017982, 4801.759912004421, 5784.971075144597, 6017.428344307284, 6285.0886621440095, 6287.371262873722, 4485.977570112162, 5154.948450515484, 5840.211571437886, 5971.104334349882, 5971.820845374646, 6189.690515474208, 6252.249730032425, 6260.655663938436, 6306.0, 6311.368863113652, 5150.768215430315, 5800.926828536734, 6190.659513726789, 6247.656378899113, 6273.0, 5706.28671416073, 6195.349488303754, 6265.4361107500545, 6271.686415679198, 6283.6858157091965, 5150.304708864255, 6128.258691089361, 6147.801178770186, 6174.228221472316, 6205.472534834499, 5686.77252909879, 6206.0, 6218.19163508741, 6234.75060997555, 6237.126802247689, 5017.949820501748, 5021.59827213822, 5030.0945829751, 5041.69749815005, 5053.267276244997, 4432.445944256968, 4440.62254708347, 4444.777761111932, 4505.459344878635, 4510.594046535827, 5881.441263080001, 5893.057110862242, 5930.169776231331, 6006.0, 6009.248843894513, 6195.380461953769, 6248.843778905563, 6254.718537665816, 6268.655223962726, 6285.717142728588, 5843.912341314884, 5923.585349025527, 5937.584369094208, 5939.970300148471, 5968.970155149196, 5489.670619762827, 5493.505584497335, 5515.420880807537, 5519.172124181325, 5523.8895222096135, 6434.485241180788, 6435.066915297256, 6449.419552240321, 6453.806385808433, 6465.353464653591, 6135.600157732601, 6189.876202476015, 6229.56393052482, 6243.219597550306, 6245.750169993149, 5416.539594134542, 6432.2281326241155, 6445.548811583331, 6469.061986012096, 6502.252240992347, 6155.784547540815, 6189.381061893775, 6205.81382558524, 6252.343503932204, 6275.184226050585, 6113.962834745988, 6186.041163619646, 6271.62370257786, 6275.905861411991, 6276.372362763687, 6072.90890636632, 6155.876882462415, 6158.445739883432, 6253.312135664983, 6271.0, 6228.34602366745, 6232.283287422005, 6248.343923887926, 6248.4376406123665, 6248.562600617913, 5010.9248361273885, 5925.318588362394, 5975.804839032124, 6070.1198326241565, 6163.322034576283, 6108.281362586102, 6112.47308512798, 6159.384061593805, 6161.84595385119, 6241.469475094668, 6125.754969801158, 6132.47873930703, 6152.630842149306, 6153.0, 6180.412860778219], "value": 5743.86116365844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.7335891900536, 486.96834705744124, 523.5183631059425, 530.6975024236184, 538.8383484954512, 39567.60432395679, 41543.58456415435, 41569.16861662765, 41701.582984170185, 41761.3735793963, 39135.80432097843, 39848.20303593934, 42639.0, 42699.57300426995, 43288.3506747399, 9611.711648650535, 9794.461304628243, 9804.0, 9820.705378838611, 9844.95077524615, 9664.855027174597, 9753.853692194623, 9773.218142548614, 9774.609015639366, 9806.705798826011, 8753.299736021103, 8771.429857059302, 8948.776280592972, 9757.268204884627, 9807.607695692164, 7805.37556995439, 9738.464384458852, 9762.072603102693, 9765.804683906283, 9766.902330976742, 9643.90356096437, 9682.903170968271, 9751.609935602568, 9761.951190244074, 9783.315167938246, 41008.179836403106, 41031.384529232084, 41069.589304107176, 41230.79384603088, 41889.0, 3283.277678910636, 3364.5457863188644, 3393.677600627961, 3471.531343268677, 3580.15866271426, 25051.498970020497, 29118.0, 29283.560746588817, 31901.52147717763, 31966.0, 3075.861586228603, 3107.8756849725983, 3168.112928380034, 3291.2594666200152, 3309.1892486341, 498658.0, 504872.0, 506610.0, 506795.0, 509756.45121774526, 61981.690091550154, 62547.061794073124, 62756.686216569535, 62760.68619656873, 62867.056994145125, 34338.48492272618, 34716.30567388638, 35220.47169292463, 36162.0, 36321.45517817235, 16846.747298790528, 17018.14909254532, 17037.57406064858, 17050.147492625318, 17066.829331706773, 12990.415431305613, 13035.087543872027, 13100.082994190505, 13107.934460327828, 13132.868671313356, 16095.758563621555, 18873.716894246598, 19056.333028343943, 19131.13909874059, 19228.61542769137, 6572.868542629216, 7848.568328741974, 7880.802979925547, 7923.960380198062, 8009.199080091944, 860.9139086091466, 955.0926619711302, 1004.7638804880847, 1073.5759375046812, 1081.6160263106642, 25984.220473385827, 28780.856095719806, 30394.54408183879, 30487.542686859713, 30893.84553077265, 887.2414085956543, 1046.9162467002623, 1059.1897198643044, 1106.8505751723576, 1110.5844787586966, 13811.861881381259, 14006.509772157926, 15624.92187539055, 15812.288447019911, 16109.516714498584, 705208.0, 722564.0, 723603.0, 724549.0, 724838.0, 57667.84664306691, 57706.55733606609, 58309.416905830396, 58400.70799645974, 58455.12317315244, 1116.0123290887623, 1146.2434793036389, 1257.6352857671172, 1266.911316207875, 1351.4121357209644, 29157.833686652295, 29765.0, 29885.252868678457, 29897.0, 30162.396752064396, 49241.50758492369, 49503.75248123737, 49567.27379994135, 49639.262625807925, 49835.750821247115, 627879.0, 633081.0, 633238.0, 635129.0, 642343.0, 26118.73881261239, 26125.216243512725, 26380.340491487867, 26621.0, 26622.733772662024, 46058.84852878705, 46914.76542617402, 47213.52786472091, 47525.7623711893, 48029.0, 39221.803890980365, 39330.213395731356, 39482.80258598689, 39505.81482555528, 40284.59715402809, 32552.51171232481, 38689.0, 38963.610363896, 39347.24024353636, 40043.0, 37848.81075594604, 38381.23237535178, 38538.614613854625, 38607.0, 39761.40357894692, 32220.19449513781, 34519.654803451645, 35300.0, 35403.0, 35434.29131417305, 25618.615720764577, 25863.353416164748, 25880.611790822775, 26168.73831261663, 26465.0], "value": 19786.760377723927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.41279603818043, 378.47581100176245, 381.4945197613163, 385.0489291450117, 400.22356628141404, 18513.629727405445, 20092.899535502303, 21307.25424610137, 21453.141874325007, 21535.46161345965, 19481.415557533295, 19545.609087818237, 20134.89932550339, 20185.798142018575, 20476.18095276187, 5377.193420986844, 5432.70120143391, 5566.610337276392, 5630.268065151525, 5669.319681638209, 3894.6884249259992, 5495.0, 5506.476884695948, 5545.556355491551, 5552.611317207797, 4111.917761644765, 5880.764769409218, 6113.23584551931, 6157.846053848667, 6208.565400421972, 5999.790007349744, 6130.0, 6186.783462578788, 6206.224221972254, 6245.500359971192, 5984.581079324449, 6025.548083893682, 6025.728842202111, 6035.094735789623, 6044.576879618428, 12732.87267127326, 13045.86954130456, 13059.020573456934, 13117.803232951514, 13205.943524518112, 2231.0964059555745, 2279.7606251343536, 2397.6883005209384, 2764.9447011059665, 2829.1936798012675, 9395.62417503299, 9811.411315321104, 14016.92991535046, 14475.565733028026, 15378.692426151414, 1839.6044850357237, 1890.6596812573732, 1925.5571218619655, 1943.543267332176, 1949.9415017549495, 97015.0298497013, 115376.0, 118284.22573661403, 119837.0, 127672.0, 9698.806023879482, 11214.551417943354, 11247.66257012291, 11558.768824623628, 11905.761884762256, 11567.710807229887, 12116.878831211576, 13745.793813092812, 14150.221737804313, 14600.41598336076, 7028.332308430691, 8442.15578442151, 8566.0, 8680.435771674947, 8681.262092722189, 8573.813677512318, 8608.375051070347, 8623.31013518917, 8775.561221938877, 8859.11408859109, 4321.567843215653, 4441.200583894865, 4523.954760452353, 4536.002079542495, 4625.259958406638, 1597.1295643874116, 1894.3275137326327, 1948.6492431362492, 1956.0708663385062, 1968.8917109558824, 844.7423535821633, 857.652650676477, 900.7029876977132, 923.7644400677918, 1020.0, 16533.83466165347, 20159.39521814348, 20420.0810963507, 20739.688904666444, 21307.0, 891.9108089191029, 923.704414587339, 927.9931274567035, 939.4504215034282, 962.6871266838306, 8924.821503569892, 10422.062014418738, 10860.837087443695, 10903.182261330274, 11114.0, 619147.0, 621044.0, 631003.0, 631675.0, 632659.0, 132578.0, 133518.0, 135172.648273516, 139812.0, 141165.0, 928.7167413938679, 938.863864739609, 959.6065613098735, 960.5917485068818, 963.4652767713986, 16521.84347095692, 16909.0, 18562.628747425246, 18615.813841861407, 18884.716729249347, 56908.34609838533, 57498.7125064372, 58030.419695804194, 58730.0, 60283.49291267753, 79520.0, 79877.8018329714, 83066.33867322741, 83517.16482835094, 85558.57220713857, 6758.797236082925, 6759.357861003394, 6972.4073453757, 7165.570065796069, 7215.494915355875, 10568.418736969541, 12580.748385032066, 12588.937055314665, 12615.0, 12811.487540498649, 8646.870296945424, 10828.24202305831, 10861.945690271814, 11029.669109926715, 11061.612843550438, 10769.24615276923, 11067.0, 11134.498947547218, 11175.832362514406, 11206.0, 10226.23303252274, 10227.7443063924, 11069.778604428027, 11430.0, 11523.769524609294, 7931.365490760841, 7974.202579742211, 8269.627866746132, 8302.460340077876, 8326.916730832614, 10126.291159618757, 10889.673309800719, 11115.22193446451, 11268.718282043015, 11514.19400641947], "value": 9359.424071975414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.7356275870343, 1513.409770189626, 1693.018049531272, 1811.501836994827, 1825.1513046433406, 7814.609269536515, 8083.43415960883, 8566.957165214173, 9134.132257435542, 9163.816723665532, 8538.658453661861, 8855.158759917798, 8861.601227944742, 8967.148120928518, 8983.416077954927, 1849.7965223825436, 2027.6248893954591, 2309.9422514437106, 2363.1020212319336, 2412.577798885197, 2386.284114765572, 2413.070967677439, 2424.6726691896633, 2441.3520873410466, 2445.2297526279253, 2040.8061234182728, 2067.24545540878, 2416.6012607919674, 2426.33275849142, 2434.586120359534, 2032.2886989553613, 2048.068129001301, 2198.3844523533435, 2276.7364112917408, 2406.554787364343, 2399.9880000599887, 2406.8796560172095, 2412.541617092764, 2412.9865456508132, 2420.636904464327, 8948.597313120925, 8983.056779038172, 9055.547222638908, 9078.591463384164, 9112.772180695536, 5306.946930530722, 5391.137418013099, 5436.157395603688, 5456.399796022434, 5460.989716902386, 2859.342351259222, 3613.4747639585175, 3634.0733113056003, 3720.21875406165, 3747.306748251582, 1114.6934592986993, 1115.576081089189, 1807.2951548895942, 1858.7397764313007, 1903.172120127749, 11527.0, 11623.244489108265, 11672.941635291769, 11769.470373833197, 11804.291742495478, 4007.8196481158416, 4490.3040028795585, 4505.211587972091, 4642.3500709900645, 4669.182892993713, 9049.683261085831, 9094.499802510925, 9127.224185944136, 9155.54222288883, 9167.404118732262, 5277.23480095384, 5288.8413347599635, 5292.867678308073, 5307.124324486494, 5325.121354976385, 4400.0, 4572.3827283317, 4924.556789888928, 4957.6281778866005, 4980.501949805063, 3230.3862266169353, 3504.6144924058335, 3791.3554695701796, 3865.0867820429066, 3880.243352546283, 982.5382070426888, 1079.63292480557, 1084.2301965604352, 1092.0990183098975, 1094.026316578246, 751.9436042296741, 869.6956065377068, 906.4244204929917, 915.4507295622573, 921.5944984206927, 5059.519345662156, 5717.714114294268, 5818.4763371296785, 5870.3249126350165, 6017.548683848729, 891.7754076545747, 969.2827307792325, 970.6990832841842, 974.2303580171586, 985.5515740338129, 3839.7504162229366, 3998.9200215996098, 4021.1756589899, 4037.2329257440992, 4116.608922152391, 10623.946880265548, 10867.130629549618, 11032.227744058, 11045.83431248532, 11062.280951738112, 10861.456927153611, 10906.563737450413, 10910.23628346008, 10928.781424371628, 10936.179786516042, 7891.723789667334, 8153.918460815435, 8274.958625206835, 8291.378146639026, 8369.079401265977, 5809.215755873072, 5917.289925209003, 5936.495397891227, 5995.520358371407, 6005.579609427298, 10074.647387341702, 10211.540480678239, 10300.845487317845, 10311.587536498757, 10319.071283584513, 10014.39913605186, 10119.949400253246, 10300.690979270634, 10379.481025948824, 10472.633457828939, 6559.376859198369, 6880.415164711056, 7123.82190445243, 7142.178649455379, 7573.242675732603, 7971.0, 8125.878111828446, 8156.306713929383, 8173.34613230952, 8180.550069746221, 7191.137063552407, 7382.44631652639, 7386.2244464332625, 7399.704011839466, 7483.289087536676, 7210.603416812126, 7213.855722885618, 7232.602206878672, 7261.128664560287, 7362.7423040193335, 5421.0, 6251.9687401562705, 6415.166028416463, 6850.21222559412, 6899.482538809509, 4887.682300650446, 4898.0, 4936.629752768485, 4954.355933728736, 4961.776720047678, 4854.490278520846, 4912.238603016538, 4958.57852082577, 5009.073321435546, 5045.293658887832], "value": 4567.252228432456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0997876434403, 301.68021896789406, 308.5110100490722, 308.6959345045129, 308.8687307894145, 5245.6852588844695, 5270.683758974455, 5326.866828329294, 5434.91847622286, 5490.450954904508, 4895.5838753705975, 5061.266116413118, 5077.365329333833, 5135.075686376451, 5197.232940800127, 3438.70770984466, 4149.419081328617, 4156.937645935313, 4161.625453709165, 4186.372044193365, 3879.398693202558, 4094.34490481523, 4165.791710414483, 4171.436856024443, 4195.5175154857125, 3588.9641103588892, 4059.1733719826047, 4066.430699702044, 4089.5092588889224, 4107.158032603309, 3422.9486557701653, 3446.724262059042, 4060.7969601519953, 4065.3495440729343, 4128.504579450485, 3522.3131489359585, 3528.7353448491467, 3541.8052007139595, 3543.8405271762576, 3558.0, 4983.9252411213865, 5330.466953304677, 5345.599080069011, 5351.973240133813, 5362.410134885159, 4093.853720958107, 4685.062987402499, 4724.669273150881, 4730.172219861545, 4750.952490475085, 4992.853073178532, 5093.592512599021, 5632.493075623172, 5746.080627099644, 5817.447342502455, 3702.4631428442995, 3752.2683076800035, 3768.679662228714, 3844.942325865114, 3911.3741801311653, 4560.042391097873, 4786.545278198566, 4891.364122664067, 5533.612647114664, 5602.803901863415, 3586.300671369058, 3885.6502914737807, 3894.3184942634925, 3909.3745000799736, 3923.4507168996365, 3339.5157702133056, 3704.111013356775, 3934.3508321127265, 3952.466417033721, 3981.6217459341315, 4448.911021779546, 4659.301104834234, 4663.347131401607, 4664.836730714409, 4727.479977202505, 4924.975375123101, 5189.636725429259, 5825.912611310834, 5886.1752856614585, 5887.911681324784, 1261.369315342329, 1300.9787316956144, 1319.3771660857008, 1345.327336331834, 1347.8854297384637, 768.1435199752236, 818.5743413424985, 876.4303202918027, 904.8371293167162, 914.4421902639384, 5020.472850350734, 5387.730613469311, 5388.380336261302, 5394.62237643369, 5421.891562168735, 5443.700596467233, 5451.092117758832, 5862.267216597926, 5875.588708790429, 5884.617499862496, 4235.449391579075, 4902.779374928136, 5034.949650503521, 5292.470752924677, 5337.8131765388025, 2496.3883848457244, 2566.84385116503, 2584.483103379294, 2615.6207349934534, 2615.9869200653875, 4409.302418568874, 4592.632589392841, 5044.419891712427, 5104.310918026019, 5205.24523944026, 4571.9085618287445, 4778.856634300976, 4928.926066109011, 5128.820491282787, 5456.0, 5154.587632989352, 6264.342244064399, 6268.49852011838, 6293.937060629335, 6304.527160463075, 5188.066148093229, 6026.668533230714, 6050.42520960508, 6077.604955677867, 6121.112438696453, 5332.760025798771, 5870.031444811559, 5884.529237661062, 5919.792807251725, 5940.8811823764145, 6216.595921265103, 6242.469390101892, 6275.592086514362, 6301.747930082745, 6333.240011198685, 3630.7640003399692, 3825.980870095632, 3874.6900247980657, 3912.5304963404574, 3928.6857051435245, 5643.35101463337, 5678.5457163426, 5975.37258587842, 5984.294476074298, 6012.1582978382185, 5127.154634024481, 5313.309269794902, 5536.003519366392, 5856.0, 5869.911951320819, 5047.470015648304, 5475.780968761205, 5782.710864456676, 5834.241548598655, 5883.823485295448, 5278.788848446019, 5600.747966341443, 5686.857828554319, 5693.430656934273, 5708.343540492897, 5247.422783493889, 5510.228568000563, 5825.446582574648, 5841.174031009696, 5878.647281163144, 4765.7140571565815, 5679.0, 5709.885802284014, 5750.367459579359, 5780.161876527964], "value": 4102.869066653936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.3055312773131, 714.8463080437705, 773.7678696391081, 774.8725604245823, 820.8850760893476, 13793.51722689706, 13872.722545549082, 14928.701425971474, 15390.692186156284, 15454.1500217488, 12281.44733486993, 14134.0, 14395.424183032666, 14403.78394324086, 14461.927690361534, 672.4687496877485, 693.0574418790441, 813.9959300203506, 838.5388036579888, 844.8943882014748, 832.309183377798, 854.133054949227, 863.3913091270639, 864.1229152410309, 865.3380164174412, 886.2821114896922, 894.2488309819751, 894.3292530602048, 894.5616647842543, 895.5566994337779, 884.3146561414891, 884.5179377239356, 885.6014793342989, 888.0, 888.942218755782, 631.050269344638, 632.294991084937, 654.5156584127759, 658.1148355461896, 660.1220376898713, 11427.771444571144, 12402.689932751664, 13527.917766578748, 14451.0, 14809.0, 14138.85861141396, 14280.000399972007, 14312.856871431257, 14400.855991440056, 14627.488037918729, 10404.843927341097, 11314.490847911782, 11316.377599232039, 11625.534978600846, 11777.0, 3116.750659947199, 3798.4682144499793, 3856.5372155341256, 3949.3878448840474, 3951.881443556698, 112972.26577714738, 117608.0, 117919.41040294744, 118426.40786796097, 118746.0, 10608.15134789215, 10784.460776961278, 10927.453627318602, 11061.059809916087, 11408.429578521042, 21997.010134543663, 22220.444488887908, 22222.555548888933, 22309.442263943532, 22449.0, 7946.205379462008, 7966.6415011324625, 8014.71948481812, 8068.47554908929, 8167.0199576051255, 4424.33634954753, 4465.24090904547, 4553.954460455419, 4593.333966574828, 4668.393108895822, 3539.94690079649, 3616.1321282891918, 3642.85428582859, 3657.65252301031, 3671.8714844980295, 642.858571114354, 657.7040331850591, 660.7092879133262, 663.2637772072995, 667.5794249622707, 578.7974209026892, 588.109014842514, 602.3494625804121, 622.7602373086304, 646.7994921574327, 9335.393199442015, 9339.626414943463, 9408.388454750557, 9682.080202380763, 9841.655542055994, 632.7089538812106, 650.8210242183343, 668.6422763821332, 670.4904272752743, 675.1998881325645, 4571.0, 4725.29120631908, 4725.621950243973, 4770.689905156154, 4779.163646361872, 146155.0, 172203.27796721872, 172725.0, 174424.0, 175456.0, 111109.0, 132677.33661331824, 135317.3234133823, 135800.32099839437, 145406.5459345414, 80769.0, 82545.0, 119620.40189798996, 124491.37754311171, 130853.69146308606, 8703.43427677199, 8924.955375223342, 9071.183593476619, 9125.634974600942, 9223.21602663781, 55461.445385547246, 68450.3154968464, 68841.0, 69350.65324673345, 71147.0, 98312.0, 108357.0, 111201.0, 113141.43429282801, 113890.0, 11553.884461155618, 11791.469383877575, 11824.467898944396, 11994.220375675553, 12216.87783122193, 12198.878011219775, 12313.56902508408, 12841.614751557468, 12864.356782160667, 12907.548235811702, 12498.0, 13504.93247533756, 13535.458581656623, 13609.659758506117, 14005.299735013412, 12944.032648035572, 12957.02822288351, 13396.531121410704, 13745.450181992608, 14281.0, 11036.668899933014, 12343.889049985186, 12849.486020559072, 13026.47894084226, 13874.774994889016, 10925.672229833117, 11434.428278586203, 11529.711757205801, 11634.76730465403, 11867.703307417038, 8966.282697384064, 10402.47987600632, 10407.895921040996, 11535.711607209887, 11824.46789894474], "value": 7785.817925021713, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 119.0, 117.0, 120.0, 117.0, 117.0, 120.0, 141.0, 120.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 112.0, 133.0, 138.0, 148.0, 140.0, 125.0, 142.0, 110.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 203.0, 197.0, 198.0, 194.0, 195.0, 198.0, 197.0, 194.0], "value": 197.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 84.0, 60.0, 58.0, 59.0, 59.0, 83.0, 52.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 89.0, 73.0, 72.0, 70.0, 90.0, 69.0, 70.0, 87.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 89.0, 86.0, 89.0, 96.0, 132.0, 87.0, 89.0, 85.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 171.0, 164.0, 98.0, 99.0, 100.0, 129.0, 168.0, 152.0], "value": 132.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 90.0, 120.0, 118.0, 89.0, 91.0, 93.0, 142.0, 148.0], "value": 107.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 57.0, 59.0, 59.0, 57.0, 65.0, 82.0, 86.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 83.0, 84.0, 74.0, 70.0, 68.0, 70.0, 70.0, 74.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 81.0, 85.0, 84.0, 83.0, 88.0, 88.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 158.0, 148.0, 147.0, 155.0, 147.0, 140.0, 139.0, 170.0, 157.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 166.0, 165.0, 165.0, 168.0, 173.0, 161.0, 179.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 70.0, 77.0, 88.0, 85.0, 80.0, 67.0, 64.0, 67.0], "value": 74.6, "unit": "score"}]}]} 09:39:51 INFO - Return code: 0 09:39:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:51 ERROR - # TBPL SUCCESS # 09:39:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:51 INFO - 2016-10-12 09:39:51.607 screenresolution[1951:20969] starting screenresolution argv=screenresolution get 09:39:51 INFO - 2016-10-12 09:39:51.610 screenresolution[1951:20969] Display 0: 1600x1200x32@60 09:39:51 INFO - 2016-10-12 09:39:51.616 screenresolution[1952:20971] starting screenresolution argv=screenresolution list 09:39:51 INFO - Available Modes on Display 0 09:39:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:51 INFO - Intel Iris: 09:39:51 INFO - Chipset Model: Intel Iris 09:39:51 INFO - Type: GPU 09:39:51 INFO - Bus: Built-In 09:39:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:51 INFO - Vendor: Intel (0x8086) 09:39:51 INFO - Device ID: 0x0a2e 09:39:51 INFO - Revision ID: 0x0009 09:39:51 INFO - Displays: 09:39:51 INFO - Display: 09:39:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:51 INFO - Display Serial Number: 1600x1200 60 09:39:51 INFO - Main Display: Yes 09:39:51 INFO - Mirror: Off 09:39:51 INFO - Online: Yes 09:39:51 INFO - Rotation: Supported 09:39:51 INFO - Return code: 0 09:39:51 INFO - Running post-action listener: _resource_record_post_action 09:39:51 INFO - [mozharness: 2016-10-12 16:39:51.852083Z] Finished run-tests step (success) 09:39:51 INFO - Running post-run listener: _resource_record_post_run 09:39:51 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 2297856; Write bytes: 665451520; Read time: 17; Write time: 1924 09:39:51 INFO - TinderboxPrint: CPU usage
54.4% 09:39:51 INFO - TinderboxPrint: I/O read bytes / time
2,297,856 / 17 09:39:51 INFO - TinderboxPrint: I/O write bytes / time
665,451,520 / 1,924 09:39:51 INFO - TinderboxPrint: CPU idle
2,199.6 (45.6%) 09:39:51 INFO - TinderboxPrint: CPU system
976.2 (20.2%) 09:39:51 INFO - TinderboxPrint: CPU user
1,649.8 (34.2%) 09:39:51 INFO - TinderboxPrint: Swap in / out
365,903,872 / 0 09:39:51 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356000256; Write bytes: 356640256; Read time: 27296; Write time: 738 09:39:51 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 2297856; Write bytes: 298624512; Read time: 17; Write time: 1154 09:39:52 INFO - Running post-run listener: _upload_blobber_files 09:39:52 INFO - Blob upload gear active. 09:39:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:52 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 09:39:52 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'] 09:39:52 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 09:39:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:53 INFO - (blobuploader) - INFO - Done attempting. 09:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:54 INFO - (blobuploader) - INFO - Done attempting. 09:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:57 INFO - (blobuploader) - INFO - Done attempting. 09:39:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:57 INFO - Return code: 0 09:39:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f037aafcfa07d9a4eb7a73a65a58707d8d6f4222a2d6c3dcbb59b2051c67c453343b3931bebe7c0d964e395d115eaa61a0e46c8f92611345b01a6b56136eb965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c38902f324ddb8a95423d6ff953c0aaa57758a8db3b06c37e40a4180e63753566450ec5f286c04b528fb07ebdd9b97434f75efb3759425ec207e181ec2ca0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d4073e011730adea668ce3f15fb0e8b9c0097214d023f73b86cedb945a91dc0aa8f359efbf1ae7919f41bc052f0920fc9191652ccc47761a7d3bc864150b16c"} 09:39:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:57 INFO - Contents: 09:39:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f037aafcfa07d9a4eb7a73a65a58707d8d6f4222a2d6c3dcbb59b2051c67c453343b3931bebe7c0d964e395d115eaa61a0e46c8f92611345b01a6b56136eb965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c38902f324ddb8a95423d6ff953c0aaa57758a8db3b06c37e40a4180e63753566450ec5f286c04b528fb07ebdd9b97434f75efb3759425ec207e181ec2ca0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d4073e011730adea668ce3f15fb0e8b9c0097214d023f73b86cedb945a91dc0aa8f359efbf1ae7919f41bc052f0920fc9191652ccc47761a7d3bc864150b16c"} 09:39:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:57 INFO - Copying logs to upload dir... 09:39:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.476066 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-12 09:39:57.254324) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 09:39:57.258511) ========= 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.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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/f037aafcfa07d9a4eb7a73a65a58707d8d6f4222a2d6c3dcbb59b2051c67c453343b3931bebe7c0d964e395d115eaa61a0e46c8f92611345b01a6b56136eb965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c38902f324ddb8a95423d6ff953c0aaa57758a8db3b06c37e40a4180e63753566450ec5f286c04b528fb07ebdd9b97434f75efb3759425ec207e181ec2ca0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d4073e011730adea668ce3f15fb0e8b9c0097214d023f73b86cedb945a91dc0aa8f359efbf1ae7919f41bc052f0920fc9191652ccc47761a7d3bc864150b16c"} build_url:https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/abLA12oPQ0KlWpSpULAjWQ/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/f037aafcfa07d9a4eb7a73a65a58707d8d6f4222a2d6c3dcbb59b2051c67c453343b3931bebe7c0d964e395d115eaa61a0e46c8f92611345b01a6b56136eb965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c38902f324ddb8a95423d6ff953c0aaa57758a8db3b06c37e40a4180e63753566450ec5f286c04b528fb07ebdd9b97434f75efb3759425ec207e181ec2ca0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d4073e011730adea668ce3f15fb0e8b9c0097214d023f73b86cedb945a91dc0aa8f359efbf1ae7919f41bc052f0920fc9191652ccc47761a7d3bc864150b16c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 09:39:57.293125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:39:57.293475) ========= 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.fnYtE3IHPN/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.fImOtABccD/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.005287 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:39:57.343273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 09:39:57.343611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 09:39:57.344003) ========= ========= Total master_lag: 0.19 =========